Mar 04 07:58:02 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 04 07:58:12 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 04 07:58:12 volumio volumio-remote-updater[884]: Test mode disabled Mar 04 07:58:12 volumio volumio-remote-updater[884]: Alpha mode disabled Mar 04 07:58:12 volumio volumio-remote-updater[884]: Alpha legacy test mode disabled Mar 04 07:58:12 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 04 07:58:12 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 04 07:58:13 volumio volumio[65241]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 04 07:58:13 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioSeek Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::seek Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: TRACKBLOCK {"uri":"mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","service":"mpd","name":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=707&web=%E8%AE%B8%E6%85%A7%E6%AC%A3/%E7%BE%8E%E4%B8%BD%E7%9A%84%E7%88%B1%E6%83%85/extralarge&path=%2FNAS%2FFn-NAS%2F0012&metadata=false","duration":249,"trackType":"flac","samplerate":"192 kHz","bitdepth":"24 bit","channels":2} Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: ControllerMpd::seek Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.404Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=70000 volume=100 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.404Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:15 volumio volumio[65241]: error: null Mar 04 07:58:15 volumio volumio[65241]: info: Mar 04 07:58:15 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:15 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:15 volumio volumio[65241]: info: Mar 04 07:58:15 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:15 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:15 volumio volumio[65241]: info: Mar 04 07:58:15 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:15 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:15 volumio volumio[65241]: info: sendMpdCommand status took 3 milliseconds Mar 04 07:58:15 volumio volumio[65241]: info: sendMpdCommand status took 2 milliseconds Mar 04 07:58:15 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:15 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:58:15 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:58:15 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:15 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:15 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3515 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:15 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:15 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:15 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3515 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:15 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:15 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:15 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3515 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:15 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:15 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:15 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:15 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:15 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.437Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=70000 volume=100 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.437Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.437Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=70000 volume=100 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.437Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.443Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=70000 volume=100 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.443Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.444Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=70000 volume=100 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.444Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.444Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=70000 volume=100 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.444Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.444Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=70000 volume=100 Mar 04 07:58:15 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:15.444Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:15 volumio volumio[65241]: info: ------------------------------ 47ms Mar 04 07:58:15 volumio volumio[65241]: info: ------------------------------ 46ms Mar 04 07:58:15 volumio volumio[65241]: info: ------------------------------ 45ms Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioSeek Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::seek Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: TRACKBLOCK {"uri":"mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","service":"mpd","name":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=707&web=%E8%AE%B8%E6%85%A7%E6%AC%A3/%E7%BE%8E%E4%B8%BD%E7%9A%84%E7%88%B1%E6%83%85/extralarge&path=%2FNAS%2FFn-NAS%2F0012&metadata=false","duration":249,"trackType":"flac","samplerate":"192 kHz","bitdepth":"24 bit","channels":2} Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: ControllerMpd::seek Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.439Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.440Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:18 volumio volumio[65241]: error: null Mar 04 07:58:18 volumio volumio[65241]: info: Mar 04 07:58:18 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:18 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:18 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:18 volumio volumio[65241]: info: Mar 04 07:58:18 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:18 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:18 volumio volumio[65241]: info: Mar 04 07:58:18 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:18 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:18 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:58:18 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:58:18 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:18 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5939 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:18 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:18 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.451Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.451Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.451Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.454Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:18 volumio volumio[65241]: info: ------------------------------ 13ms Mar 04 07:58:18 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 04 07:58:18 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:18 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:18 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5939 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:18 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:18 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:18 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5939 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:18 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:18 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:18 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:18 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:18 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.474Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.474Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.475Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.475Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.475Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.475Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.475Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:58:18 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:18.475Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:18 volumio volumio[65241]: info: ------------------------------ 39ms Mar 04 07:58:18 volumio volumio[65241]: info: ------------------------------ 39ms Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioSeek Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::seek Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: TRACKBLOCK {"uri":"mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","service":"mpd","name":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=707&web=%E8%AE%B8%E6%85%A7%E6%AC%A3/%E7%BE%8E%E4%B8%BD%E7%9A%84%E7%88%B1%E6%83%85/extralarge&path=%2FNAS%2FFn-NAS%2F0012&metadata=false","duration":249,"trackType":"flac","samplerate":"192 kHz","bitdepth":"24 bit","channels":2} Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: ControllerMpd::seek Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.251Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=103000 volume=100 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.251Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:39 volumio volumio[65241]: error: null Mar 04 07:58:39 volumio volumio[65241]: info: Mar 04 07:58:39 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:39 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:39 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:39 volumio volumio[65241]: info: Mar 04 07:58:39 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:39 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:39 volumio volumio[65241]: info: Mar 04 07:58:39 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:58:39 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:58:39 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:39 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":103000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4876 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:39 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:39 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:39 volumio volumio[65241]: info: ------------------------------ 17ms Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.319Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=103000 volume=100 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.319Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.319Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=103000 volume=100 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.319Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:39 volumio volumio[65241]: info: sendMpdCommand status took 17 milliseconds Mar 04 07:58:39 volumio volumio[65241]: info: sendMpdCommand status took 16 milliseconds Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:58:39 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 04 07:58:39 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:39 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:58:39 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":103000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4876 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:39 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:39 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:39 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":103000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4876 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:58:39 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:58:39 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:39 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:58:39 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:58:39 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.342Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=103000 volume=100 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.342Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.343Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=103000 volume=100 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.343Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.344Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=103000 volume=100 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.344Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.346Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=103000 volume=100 Mar 04 07:58:39 volumio volumio5-onboarding[1648]: time=2026-03-04T07:58:39.346Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:58:39 volumio volumio[65241]: info: ------------------------------ 47ms Mar 04 07:58:39 volumio volumio[65241]: info: ------------------------------ 52ms Mar 04 07:58:59 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 04 07:58:59 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 04 07:58:59 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 04 07:59:06 volumio kernel: perf: interrupt took too long (3926 > 3923), lowering kernel.perf_event_max_sample_rate to 50750 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioSeek Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::seek Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: TRACKBLOCK {"uri":"mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","service":"mpd","name":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=707&web=%E8%AE%B8%E6%85%A7%E6%AC%A3/%E7%BE%8E%E4%B8%BD%E7%9A%84%E7%88%B1%E6%83%85/extralarge&path=%2FNAS%2FFn-NAS%2F0012&metadata=false","duration":249,"trackType":"flac","samplerate":"192 kHz","bitdepth":"24 bit","channels":2} Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: ControllerMpd::seek Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.970Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.970Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:19 volumio volumio[65241]: error: null Mar 04 07:59:19 volumio volumio[65241]: info: Mar 04 07:59:19 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:19 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:19 volumio volumio[65241]: info: Mar 04 07:59:19 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:19 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:19 volumio volumio[65241]: info: Mar 04 07:59:19 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:19 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:19 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:19 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:19 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:19 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:19 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5580 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:59:19 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:19 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.978Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.979Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.979Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.979Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:19 volumio volumio[65241]: info: ------------------------------ 11ms Mar 04 07:59:19 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 04 07:59:19 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:19 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:19 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5580 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:59:19 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:19 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:19 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5580 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:59:19 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:19 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:19 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:19 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:19 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.993Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.993Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.994Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.994Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.994Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.994Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:19 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.999Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:20 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:19.999Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:20 volumio volumio[65241]: info: ------------------------------ 31ms Mar 04 07:59:20 volumio volumio[65241]: info: ------------------------------ 31ms Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioSeek Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::seek Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: TRACKBLOCK {"uri":"mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","service":"mpd","name":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=707&web=%E8%AE%B8%E6%85%A7%E6%AC%A3/%E7%BE%8E%E4%B8%BD%E7%9A%84%E7%88%B1%E6%83%85/extralarge&path=%2FNAS%2FFn-NAS%2F0012&metadata=false","duration":249,"trackType":"flac","samplerate":"192 kHz","bitdepth":"24 bit","channels":2} Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: ControllerMpd::seek Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.652Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=207000 volume=100 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.652Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:31 volumio volumio[65241]: error: null Mar 04 07:59:31 volumio volumio[65241]: info: Mar 04 07:59:31 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:31 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:31 volumio volumio[65241]: info: Mar 04 07:59:31 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:31 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:31 volumio volumio[65241]: info: Mar 04 07:59:31 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:31 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:31 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:31 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:31 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:59:31 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 04 07:59:31 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:31 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":207000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5715 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:59:31 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:31 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:31 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":207000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5715 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:59:31 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:31 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.714Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=207000 volume=100 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.714Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=207000 volume=100 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.714Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.714Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.715Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=207000 volume=100 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.715Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.715Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=207000 volume=100 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.715Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:31 volumio volumio[65241]: info: ------------------------------ 15ms Mar 04 07:59:31 volumio volumio[65241]: info: ------------------------------ 16ms Mar 04 07:59:31 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 15 milliseconds Mar 04 07:59:31 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:31 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":207000,"duration":249,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5715 Kbps","isStreaming":false,"title":"七月七日晴","artist":"许慧欣","album":"美丽的爱情","uri":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:59:31 volumio volumio[65241]: verbose: CURRENT POSITION 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:31 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:31 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:31 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:31 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.728Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=207000 volume=100 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.728Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.728Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=207000 volume=100 Mar 04 07:59:31 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:31.728Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:31 volumio volumio[65241]: info: ------------------------------ 28ms Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioNext Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::next Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::stop Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::stPlaybackTimer Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::updateTrackBlock Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrackBlock Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::serviceStop Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 3 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::serviceStop Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::stop Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.416Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.416Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac" title=七月七日晴 Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand stop took 13 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::play index undefined Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::clearAddPlayTracks NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::updateTrackBlock Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrackBlock Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand stop took 1 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand clear Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:32 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 3 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand clear took 2 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand add "NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: 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":"NAS/Fn-NAS/0012/七月七日晴 - 许慧欣.flac","trackType":"flac"} Mar 04 07:59:32 volumio volumio[65241]: verbose: CURRENT POSITION 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState stateService stop Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: No code Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.439Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.439Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.439Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.440Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.440Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.440Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 16ms Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 15ms Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:32 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:32 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:32 volumio volumio[65241]: error: updateQueue error: null Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:32 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 14ms Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand add "NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" took 13 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 2ms Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 2ms Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand play Mar 04 07:59:32 volumio volumio[65241]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 18ms Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:32 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:32 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 8ms Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand play took 6 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 5ms Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 5ms Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 62 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 62 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 62 milliseconds Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: info: Mar 04 07:59:32 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 2 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7,"duration":232,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2217 Kbps","isStreaming":false,"title":"不小心犯的错","artist":"郑源","album":"梦中情人","uri":"NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac","trackType":"flac"} Mar 04 07:59:32 volumio volumio[65241]: verbose: CURRENT POSITION 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7,"duration":232,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2217 Kbps","isStreaming":false,"title":"不小心犯的错","artist":"郑源","album":"梦中情人","uri":"NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac","trackType":"flac"} Mar 04 07:59:32 volumio volumio[65241]: verbose: CURRENT POSITION 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:32 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7,"duration":232,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2217 Kbps","isStreaming":false,"title":"不小心犯的错","artist":"郑源","album":"梦中情人","uri":"NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac","trackType":"flac"} Mar 04 07:59:32 volumio volumio[65241]: verbose: CURRENT POSITION 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:32 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 73ms Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.613Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=7 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.613Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=7 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.613Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=7 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.613Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=7 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.614Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.614Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.614Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.614Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 84ms Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 84ms Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 22 milliseconds Mar 04 07:59:32 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 21 milliseconds Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":232,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3984 Kbps","isStreaming":false,"title":"不小心犯的错","artist":"郑源","album":"梦中情人","uri":"NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac","trackType":"flac"} Mar 04 07:59:32 volumio volumio[65241]: verbose: CURRENT POSITION 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:32 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":232,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3984 Kbps","isStreaming":false,"title":"不小心犯的错","artist":"郑源","album":"梦中情人","uri":"NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac","trackType":"flac"} Mar 04 07:59:32 volumio volumio[65241]: verbose: CURRENT POSITION 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:32 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":232,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3984 Kbps","isStreaming":false,"title":"不小心犯的错","artist":"郑源","album":"梦中情人","uri":"NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac","trackType":"flac"} Mar 04 07:59:32 volumio volumio[65241]: verbose: CURRENT POSITION 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:32 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:32 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:32 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.630Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.630Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.632Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.632Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.633Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.633Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.634Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.634Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.635Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.635Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.636Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:32 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:32.636Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 49ms Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 49ms Mar 04 07:59:32 volumio volumio[65241]: info: ------------------------------ 48ms Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioNext Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::next Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::stPlaybackTimer Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::updateTrackBlock Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrackBlock Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::serviceStop Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 4 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::serviceStop Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::stop Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.769Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.769Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac" title=不小心犯的错 Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand stop took 7 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::play index undefined Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::clearAddPlayTracks NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::updateTrackBlock Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrackBlock Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand stop took 0 milliseconds Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand clear Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:37 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand clear took 1 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand add "NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: 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":"NAS/Fn-NAS/0012/不小心犯的错 - 郑源.flac","trackType":"flac"} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: No code Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: No code Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: No code Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.789Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.789Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.789Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.789Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.789Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.789Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.789Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.790Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.790Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.790Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.790Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.790Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.790Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.790Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.791Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.791Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.791Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.791Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 28ms Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 27ms Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 26ms Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:37 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:37 volumio volumio[65241]: error: updateQueue error: null Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:37 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 27ms Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand add "NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" took 27 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 0ms Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand play Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:37 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:37 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 11ms Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand play took 11 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 11ms Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 10ms Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:37 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 107ms Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 0 milliseconds Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: Mar 04 07:59:37 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 3 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 2 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand status took 3 milliseconds Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":260,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3975 Kbps","isStreaming":false,"title":"为你我受冷风吹","artist":"林忆莲","album":"Love, Sandy","uri":"NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac","trackType":"flac"} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":260,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3975 Kbps","isStreaming":false,"title":"为你我受冷风吹","artist":"林忆莲","album":"Love, Sandy","uri":"NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac","trackType":"flac"} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:37 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":260,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3975 Kbps","isStreaming":false,"title":"为你我受冷风吹","artist":"林忆莲","album":"Love, Sandy","uri":"NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac","trackType":"flac"} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:37 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 10ms Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.934Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.934Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.934Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.934Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.935Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.935Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.935Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.935Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 17ms Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 18ms Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 04 07:59:37 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:37 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":260,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3975 Kbps","isStreaming":false,"title":"为你我受冷风吹","artist":"林忆莲","album":"Love, Sandy","uri":"NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac","trackType":"flac"} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:37 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":260,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3975 Kbps","isStreaming":false,"title":"为你我受冷风吹","artist":"林忆莲","album":"Love, Sandy","uri":"NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac","trackType":"flac"} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:37 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":260,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3975 Kbps","isStreaming":false,"title":"为你我受冷风吹","artist":"林忆莲","album":"Love, Sandy","uri":"NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac","trackType":"flac"} Mar 04 07:59:37 volumio volumio[65241]: verbose: CURRENT POSITION 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:37 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:37 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:37 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.957Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.957Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.957Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.957Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.957Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.958Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.958Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.958Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.958Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.958Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.959Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:37 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:37.959Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 43ms Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 42ms Mar 04 07:59:37 volumio volumio[65241]: info: ------------------------------ 42ms Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::volumioNext Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::next Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::stop Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::stPlaybackTimer Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::updateTrackBlock Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrackBlock Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::serviceStop Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 5 Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::serviceStop Mar 04 07:59:40 volumio volumio[65241]: info: ControllerMpd::stop Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.923Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.923Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac" title=为你我受冷风吹 Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand stop took 10 milliseconds Mar 04 07:59:40 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::play index undefined Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::startPlaybackTimer Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::clearAddPlayTracks NAS/Fn-NAS/0012/为爱停留 - 郑源.flac Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand stop Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::updateTrackBlock Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrackBlock Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:40 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:40 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand stop took 2 milliseconds Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand clear Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:40 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:40 volumio volumio[65241]: 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":"Love, Sandy","uri":"NAS/Fn-NAS/0012/为你我受冷风吹 - 林忆莲.flac","trackType":"flac"} Mar 04 07:59:40 volumio volumio[65241]: verbose: CURRENT POSITION 6 Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::syncState stateService stop Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:40 volumio volumio[65241]: info: No code Mar 04 07:59:40 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:40 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:40 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.940Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.940Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.940Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.940Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.940Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_STOPPED positionMs=0 volume=100 Mar 04 07:59:40 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:40.940Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:40 volumio volumio[65241]: info: ------------------------------ 12ms Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:40 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand clear took 11 milliseconds Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand add "NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:40 volumio volumio[65241]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 04 07:59:40 volumio volumio[65241]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 04 07:59:40 volumio volumio[65241]: info: ------------------------------ 13ms Mar 04 07:59:40 volumio volumio[65241]: info: ------------------------------ 12ms Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:40 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:40 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:40 volumio volumio[65241]: error: updateQueue error: null Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:40 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:40 volumio volumio[65241]: info: ------------------------------ 5ms Mar 04 07:59:40 volumio volumio[65241]: info: sendMpdCommand add "NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" took 4 milliseconds Mar 04 07:59:40 volumio volumio[65241]: info: ------------------------------ 3ms Mar 04 07:59:40 volumio volumio[65241]: info: ------------------------------ 3ms Mar 04 07:59:40 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand play Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:40 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:40 volumio volumio[65241]: info: Mar 04 07:59:40 volumio volumio[65241]: ---------------------------- MPD announces system playlist update Mar 04 07:59:40 volumio volumio[65241]: info: Ignoring MPD Status Update Mar 04 07:59:41 volumio volumio[65241]: info: Mar 04 07:59:41 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 90ms Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand play took 90 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 90ms Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 90ms Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:41 volumio volumio[65241]: info: Mar 04 07:59:41 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:41 volumio volumio[65241]: info: Mar 04 07:59:41 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:41 volumio volumio[65241]: info: Mar 04 07:59:41 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand status took 1 milliseconds Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:41 volumio volumio[65241]: info: Mar 04 07:59:41 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:41 volumio volumio[65241]: info: Mar 04 07:59:41 volumio volumio[65241]: ---------------------------- MPD announces state update: player Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::getState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand status Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand status took 39 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 38 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 38 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 38 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand status took 39 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand status took 39 milliseconds Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseState Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":340,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5329 Kbps","isStreaming":false,"title":"为爱停留","artist":"郑源","album":"爱过的人","uri":"NAS/Fn-NAS/0012/为爱停留 - 郑源.flac","trackType":"flac"} Mar 04 07:59:41 volumio volumio[65241]: verbose: CURRENT POSITION 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus stop Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":340,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5329 Kbps","isStreaming":false,"title":"为爱停留","artist":"郑源","album":"爱过的人","uri":"NAS/Fn-NAS/0012/为爱停留 - 郑源.flac","trackType":"flac"} Mar 04 07:59:41 volumio volumio[65241]: verbose: CURRENT POSITION 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:41 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":340,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5329 Kbps","isStreaming":false,"title":"为爱停留","artist":"郑源","album":"爱过的人","uri":"NAS/Fn-NAS/0012/为爱停留 - 郑源.flac","trackType":"flac"} Mar 04 07:59:41 volumio volumio[65241]: verbose: CURRENT POSITION 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:41 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 44ms Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.085Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.085Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.085Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.085Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.085Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.085Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.086Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.086Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 50ms Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 51ms Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 36 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 36 milliseconds Mar 04 07:59:41 volumio volumio[65241]: info: sendMpdCommand playlistinfo took 37 milliseconds Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:41 volumio volumio[65241]: verbose: ControllerMpd::parseTrackInfo Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":340,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5329 Kbps","isStreaming":false,"title":"为爱停留","artist":"郑源","album":"爱过的人","uri":"NAS/Fn-NAS/0012/为爱停留 - 郑源.flac","trackType":"flac"} Mar 04 07:59:41 volumio volumio[65241]: verbose: CURRENT POSITION 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:41 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":340,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5329 Kbps","isStreaming":false,"title":"为爱停留","artist":"郑源","album":"爱过的人","uri":"NAS/Fn-NAS/0012/为爱停留 - 郑源.flac","trackType":"flac"} Mar 04 07:59:41 volumio volumio[65241]: verbose: CURRENT POSITION 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:41 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: ControllerMpd::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::servicePushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1000,"duration":340,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5329 Kbps","isStreaming":false,"title":"为爱停留","artist":"郑源","album":"爱过的人","uri":"NAS/Fn-NAS/0012/为爱停留 - 郑源.flac","trackType":"flac"} Mar 04 07:59:41 volumio volumio[65241]: verbose: CURRENT POSITION 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState stateService play Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::syncState currentStatus play Mar 04 07:59:41 volumio volumio[65241]: info: Received an update from plugin. extracting info from payload Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio[65241]: info: CoreStateMachine::pushState Mar 04 07:59:41 volumio volumio[65241]: info: CorePlayQueue::getTrack 6 Mar 04 07:59:41 volumio volumio[65241]: info: CoreCommandRouter::volumioPushState Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.122Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.123Z level=INFO msg="emitting player state changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" state=STATUS_PLAYING positionMs=1000 volume=100 Mar 04 07:59:41 volumio volumio5-onboarding[1648]: time=2026-03-04T07:59:41.124Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.31.23:59334 @ 0xc00051c870" id="mnt/NAS/Fn-NAS/0012/为爱停留 - 郑源.flac" title=为爱停留 Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 90ms Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 89ms Mar 04 07:59:41 volumio volumio[65241]: info: ------------------------------ 89ms Mar 04 07:59:42 volumio volumio[65241]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 07:59:42 volumio volumio[65241]: Error: connect ETIMEDOUT 108.160.166.9:443 Mar 04 07:59:42 volumio volumio[65241]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Mar 04 07:59:42 volumio volumio[65241]: errno: -110, Mar 04 07:59:42 volumio volumio[65241]: code: 'ETIMEDOUT', Mar 04 07:59:42 volumio volumio[65241]: syscall: 'connect', Mar 04 07:59:42 volumio volumio[65241]: address: '108.160.166.9', Mar 04 07:59:42 volumio volumio[65241]: port: 443 Mar 04 07:59:42 volumio volumio[65241]: } Mar 04 07:59:42 volumio volumio[65241]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 07:59:42 volumio sudo[66116]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-04 07:58' Mar 04 07:59:42 volumio sudo[66116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"