-- Logs begin at Sat 2025-05-10 03:48:43 CST, end at Sun 2025-05-11 11:19:38 CST. -- May 11 11:18:00 volumio volumio[12410]: info: BOOT COMPLETED May 11 11:18:05 volumio volumio-remote-updater[708]: No test mode May 11 11:18:05 volumio volumio-remote-updater[708]: No alpha test mode May 11 11:18:05 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 11 11:18:06 volumio volumio[12410]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 11 11:18:06 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 11 11:18:22 volumio sudo[12766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 11:18:22 volumio sudo[12766]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 11:18:22 volumio sudo[12766]: pam_unix(sudo:session): session closed for user root May 11 11:18:22 volumio sudo[12768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 11:18:22 volumio sudo[12768]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 11:18:22 volumio sudo[12768]: pam_unix(sudo:session): session closed for user root May 11 11:18:22 volumio volumio[12410]: verbose: New Socket.io Connection to 192.168.2.55 from 192.168.2.54 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.4 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::volumioGetVisibleSources May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::volumioGetState May 11 11:18:22 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 11:18:22 volumio volumio[12410]: info: Received Get System Info May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 11:18:22 volumio volumio[12410]: info: Discovery: Getting this device information May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::volumioGetState May 11 11:18:22 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::volumioGetState May 11 11:18:22 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:22 volumio volumio[12410]: info: Listing playlists May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 11:18:22 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 11:18:23 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 11 11:18:24 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 11 11:18:24 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 11:18:24 volumio volumio[12410]: info: Received Get System Info May 11 11:18:24 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 11:18:24 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 11:18:24 volumio volumio[12410]: info: Discovery: Getting this device information May 11 11:18:24 volumio volumio[12410]: info: CoreCommandRouter::volumioGetState May 11 11:18:24 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:24 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPlay May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::play index undefined May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::startPlaybackTimer May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::clearAddPlayTracks NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand stop May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand stop took 1 milliseconds May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand clear May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:25 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand clear took 0 milliseconds May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand add "NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac" May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:25 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:25 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:25 volumio volumio[12410]: error: updateQueue error: null May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:25 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 3ms May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand add "NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac" took 2 milliseconds May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 2ms May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 1ms May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand play May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:25 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:25 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 2ms May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand play took 1 milliseconds May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 1ms May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 1ms May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand status took 2 milliseconds May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand status took 2 milliseconds May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand status took 4 milliseconds May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand status took 2 milliseconds May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 3 milliseconds May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand status took 1 milliseconds May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:25 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus stop May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"623 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:25 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:25 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 15ms May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 21ms May 11 11:18:25 volumio volumio[12410]: info: May 11 11:18:25 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 17 milliseconds May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 16 milliseconds May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 15 milliseconds May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"606 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:25 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:25 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:25 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:25 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:25 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:25 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 46ms May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 46ms May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 44ms May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand status took 32 milliseconds May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:25 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 1 milliseconds May 11 11:18:25 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:25 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"581 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:25 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:25 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:25 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:25 volumio volumio[12410]: info: ------------------------------ 41ms May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioSeek May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::seek May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: TRACKBLOCK {"uri":"mnt/NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","service":"mpd","name":"可否想起我","artist":"叶蕴仪","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=542&web=%E5%8F%B6%E8%95%B4%E4%BB%AA//extralarge&path=%2FNAS%2Fdsm7%2FMusic1%2FKTV%E7%83%AD%E6%AD%8C&metadata=false","duration":306,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::startPlaybackTimer May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: ControllerMpd::seek May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:26 volumio volumio[12410]: error: null May 11 11:18:26 volumio volumio[12410]: info: May 11 11:18:26 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:26 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:26 volumio volumio[12410]: info: May 11 11:18:26 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:26 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:26 volumio volumio[12410]: info: May 11 11:18:26 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:26 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:26 volumio volumio[12410]: info: sendMpdCommand status took 2 milliseconds May 11 11:18:26 volumio volumio[12410]: info: sendMpdCommand status took 1 milliseconds May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:26 volumio volumio[12410]: info: sendMpdCommand status took 3 milliseconds May 11 11:18:26 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 11:18:26 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:26 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":133000,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"619 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:26 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:26 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:26 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":133000,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"619 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:26 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:26 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:26 volumio volumio[12410]: info: ------------------------------ 21ms May 11 11:18:26 volumio volumio[12410]: info: ------------------------------ 20ms May 11 11:18:26 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 20 milliseconds May 11 11:18:26 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:26 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":133842,"duration":306,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"748 Kbps","isStreaming":false,"title":"可否想起我","artist":"叶蕴仪","album":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:26 volumio volumio[12410]: verbose: CURRENT POSITION 0 May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:26 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:26 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:26 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:26 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:26 volumio volumio[12410]: info: ------------------------------ 35ms May 11 11:18:30 volumio volumio[12410]: info: CoreCommandRouter::volumioGetQueue May 11 11:18:30 volumio volumio[12410]: info: CoreStateMachine::getQueue May 11 11:18:30 volumio volumio[12410]: info: CorePlayQueue::getQueue May 11 11:18:30 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%A8%E5%8D%83%E5%AC%85/Miriam/44cded69-0558-405a-b39c-0f0fc7521cac.jpg' May 11 11:18:30 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%90%B4%E9%9B%A8%E9%9C%8F/My%20January/f1333d29-98bd-4969-bcdd-bec977c85d82.jpg' May 11 11:18:30 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%85%B3%E6%B7%91%E6%80%A1/My%20Way/8eb37b74-ed27-48f4-9117-7470cca43ebe.jpg' May 11 11:18:30 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%96%9B%E5%87%AF%E7%90%AA/Read%20Me/0aac007c-3141-4a39-9615-bf1f74d16e95.jpg' May 11 11:18:31 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Boy%27z/Ready%20to%20Go/d83698ce-1353-4acf-8455-3a5d751b750d.png' May 11 11:18:31 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/The%20Line-Up/85e1fb09-a3e3-476f-81a1-54869fa704ff.jpg' May 11 11:18:31 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Twins/Touch%20Of%20Love/27ec29fd-c4c1-400d-acc3-d38eafc2ae25.png' May 11 11:18:31 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E6%95%AC%E8%BD%A9/Urban%20Emotions/954b30f2-9225-4dba-9a92-402e1448a567.jpg' May 11 11:18:31 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%99%88%E5%A5%95%E8%BF%85/What%27s%20Going%20On...%3F/b9d14b6f-9007-4f10-a93e-e4da11d7f336.jpg' May 11 11:18:31 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B0%A2%E5%AE%89%E7%90%AA/Yelling/6a0ad435-3a3a-48d9-976e-c804f5488599.jpg' May 11 11:18:31 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E6%AC%A3%E5%BD%A4/%E4%B8%8D%E5%A6%82%E6%86%8E%E4%BD%A0/9f97f0ab-96c6-4866-9943-3f27516f943e.jpg' May 11 11:18:32 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPlay May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::play index 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::stop May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::stPlaybackTimer May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::updateTrackBlock May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrackBlock May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::serviceStop May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 0 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::serviceStop May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::stop May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand stop May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand stop took 7 milliseconds May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::play index undefined May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::startPlaybackTimer May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::clearAddPlayTracks NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand stop May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 3 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand stop took 2 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 1 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 1 milliseconds May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand clear May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:35 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 4 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand clear took 4 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 4 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 4 milliseconds May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand add "NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac" May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: 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":null,"uri":"NAS/dsm7/Music1/KTV热歌/叶蕴仪+-+可否想起我.flac","trackType":"flac"} May 11 11:18:35 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState stateService stop May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus stop May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: No code May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 11 11:18:35 volumio volumio[12410]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 19ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 18ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 17ms May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:35 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:35 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:35 volumio volumio[12410]: error: updateQueue error: null May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:35 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 13ms May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand add "NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac" took 12 milliseconds May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 2ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 1ms May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand play May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:35 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces system playlist update May 11 11:18:35 volumio volumio[12410]: info: Ignoring MPD Status Update May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 5ms May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand play took 4 milliseconds May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 4ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 3ms May 11 11:18:35 volumio volumio[12410]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B0%A2%E5%AE%89%E7%90%AA/Binary/d8f7d34a-e912-4b3b-9760-6d61a68991ca.jpg' May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: May 11 11:18:35 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 5 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 5 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 4 milliseconds May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 2 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 1 milliseconds May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand status took 4 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 3 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 3 milliseconds May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 2 milliseconds May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:35 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus stop May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:35 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:35 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:35 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:35 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:35 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:35 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:35 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:35 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 21ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 41ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 41ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 40ms May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 39ms May 11 11:18:35 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 40 milliseconds May 11 11:18:35 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:35 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:35 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:35 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:35 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:35 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:35 volumio volumio[12410]: info: ------------------------------ 51ms May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioSeek May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::seek May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: TRACKBLOCK {"uri":"mnt/NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","service":"mpd","name":"喜帖街","artist":"谢安琪","album":"Binary","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=542&web=%E8%B0%A2%E5%AE%89%E7%90%AA/Binary/extralarge&path=%2FNAS%2Fdsm7%2FMusic1%2FKTV%E7%83%AD%E6%AD%8C&metadata=false","duration":212,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::startPlaybackTimer May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: ControllerMpd::seek May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:37 volumio volumio[12410]: error: null May 11 11:18:37 volumio volumio[12410]: info: May 11 11:18:37 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:37 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:37 volumio volumio[12410]: info: May 11 11:18:37 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:37 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:37 volumio volumio[12410]: info: May 11 11:18:37 volumio volumio[12410]: ---------------------------- MPD announces state update: player May 11 11:18:37 volumio volumio[12410]: info: ControllerMpd::getState May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand status May 11 11:18:37 volumio volumio[12410]: info: sendMpdCommand status took 3 milliseconds May 11 11:18:37 volumio volumio[12410]: info: sendMpdCommand status took 2 milliseconds May 11 11:18:37 volumio volumio[12410]: info: sendMpdCommand status took 1 milliseconds May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::parseState May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 11 11:18:37 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 1 milliseconds May 11 11:18:37 volumio volumio[12410]: info: sendMpdCommand playlistinfo took 0 milliseconds May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:37 volumio volumio[12410]: verbose: ControllerMpd::parseTrackInfo May 11 11:18:37 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":109000,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"655 Kbps","isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:37 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:37 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:37 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":109000,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"655 Kbps","isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:37 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:37 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:37 volumio volumio[12410]: info: ControllerMpd::pushState May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::servicePushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: verbose: STATE SERVICE {"status":"play","position":0,"seek":109000,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"655 Kbps","isStreaming":false,"title":"喜帖街","artist":"谢安琪","album":"Binary","uri":"NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","trackType":"flac"} May 11 11:18:37 volumio volumio[12410]: verbose: CURRENT POSITION 12 May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::syncState stateService play May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::syncState currentStatus play May 11 11:18:37 volumio volumio[12410]: info: Received an update from plugin. extracting info from payload May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:37 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:18:37 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:18:37 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:18:37 volumio volumio[12410]: info: ------------------------------ 31ms May 11 11:18:37 volumio volumio[12410]: info: ------------------------------ 31ms May 11 11:18:37 volumio volumio[12410]: info: ------------------------------ 30ms May 11 11:18:51 volumio volumio[12410]: info: CoreCommandRouter::getUIConfigOnPlugin May 11 11:18:51 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 11 11:18:51 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 11:18:51 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 11 11:18:52 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 11 11:19:20 volumio volumio[12410]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions May 11 11:19:20 volumio sudo[12930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 11:19:20 volumio sudo[12930]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 11:19:20 volumio sudo[12930]: pam_unix(sudo:session): session closed for user root May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio sudo[12933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 11:19:20 volumio sudo[12933]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 11 11:19:20 volumio systemd[1]: Stopping Music Player Daemon... May 11 11:19:20 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 11:19:20 volumio volumio[12410]: info: MPD Permissions set May 11 11:19:20 volumio systemd[1]: mpd.service: Succeeded. May 11 11:19:20 volumio systemd[1]: Stopped Music Player Daemon. May 11 11:19:20 volumio systemd[1]: Starting Music Player Daemon... May 11 11:19:20 volumio sudo[12942]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 11 11:19:20 volumio sudo[12942]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 11:19:20 volumio sudo[12942]: pam_unix(sudo:session): session closed for user root May 11 11:19:20 volumio mpd[12944]: May 11 11:19 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 11 11:19:20 volumio systemd[1]: Started Music Player Daemon. May 11 11:19:20 volumio sudo[12933]: pam_unix(sudo:session): session closed for user root May 11 11:19:20 volumio volumio[12410]: error: updateQueue error: null May 11 11:19:23 volumio volumio[12410]: info: CoreCommandRouter::volumioPause May 11 11:19:23 volumio volumio[12410]: info: CoreStateMachine::pause May 11 11:19:23 volumio volumio[12410]: info: CoreStateMachine::stPlaybackTimer May 11 11:19:23 volumio volumio[12410]: info: CoreStateMachine::servicePause May 11 11:19:23 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:23 volumio volumio[12410]: info: CoreCommandRouter::servicePause May 11 11:19:23 volumio volumio[12410]: info: ControllerMpd::pause May 11 11:19:23 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand pause May 11 11:19:23 volumio volumio[12410]: info: sendMpdCommand pause took 1 milliseconds May 11 11:19:25 volumio volumio[12410]: info: CoreCommandRouter::volumioPause May 11 11:19:25 volumio volumio[12410]: info: CoreStateMachine::pause May 11 11:19:29 volumio volumio[12410]: info: CoreCommandRouter::volumioPause May 11 11:19:29 volumio volumio[12410]: info: CoreStateMachine::pause May 11 11:19:30 volumio volumio[12410]: info: CoreCommandRouter::volumioSeek May 11 11:19:30 volumio volumio[12410]: info: CoreStateMachine::seek May 11 11:19:30 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:30 volumio volumio[12410]: info: TRACKBLOCK {"uri":"mnt/NAS/dsm7/Music1/KTV热歌/谢安琪+-+喜帖街.flac","service":"mpd","name":"喜帖街","artist":"谢安琪","album":"Binary","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=542&web=%E8%B0%A2%E5%AE%89%E7%90%AA/Binary/extralarge&path=%2FNAS%2Fdsm7%2FMusic1%2FKTV%E7%83%AD%E6%AD%8C&metadata=false","duration":212,"trackType":"flac","samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} May 11 11:19:30 volumio volumio[12410]: info: CoreStateMachine::startPlaybackTimer May 11 11:19:30 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:30 volumio volumio[12410]: info: ControllerMpd::seek May 11 11:19:30 volumio volumio[12410]: info: CoreStateMachine::pushState May 11 11:19:30 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:30 volumio volumio[12410]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 11:19:30 volumio volumio[12410]: info: CoreCommandRouter::volumioPushState May 11 11:19:30 volumio volumio[12410]: error: [2@0] {seek} Bad song index May 11 11:19:31 volumio volumio[12410]: info: CoreCommandRouter::volumioPlay May 11 11:19:31 volumio volumio[12410]: info: CoreStateMachine::play index undefined May 11 11:19:31 volumio volumio[12410]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 11:19:31 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:31 volumio volumio[12410]: info: CoreStateMachine::startPlaybackTimer May 11 11:19:31 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:31 volumio volumio[12410]: info: ControllerMpd::resume May 11 11:19:31 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand play May 11 11:19:31 volumio volumio[12410]: info: sendMpdCommand play took 0 milliseconds May 11 11:19:31 volumio volumio[12410]: info: CoreCommandRouter::volumioPlay May 11 11:19:31 volumio volumio[12410]: info: CoreStateMachine::play index undefined May 11 11:19:31 volumio volumio[12410]: info: CoreStateMachine::setConsumeUpdateService undefined May 11 11:19:31 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:31 volumio volumio[12410]: info: CoreStateMachine::startPlaybackTimer May 11 11:19:31 volumio volumio[12410]: info: CorePlayQueue::getTrack 12 May 11 11:19:31 volumio volumio[12410]: info: ControllerMpd::resume May 11 11:19:31 volumio volumio[12410]: verbose: ControllerMpd::sendMpdCommand play May 11 11:19:31 volumio volumio[12410]: info: sendMpdCommand play took 0 milliseconds May 11 11:19:38 volumio volumio[12410]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 11:19:38 volumio volumio[12410]: Error: connect ETIMEDOUT 108.160.170.41:443 May 11 11:19:38 volumio volumio[12410]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 11 11:19:38 volumio volumio[12410]: errno: -110, May 11 11:19:38 volumio volumio[12410]: code: 'ETIMEDOUT', May 11 11:19:38 volumio volumio[12410]: syscall: 'connect', May 11 11:19:38 volumio volumio[12410]: address: '108.160.170.41', May 11 11:19:38 volumio volumio[12410]: port: 443 May 11 11:19:38 volumio volumio[12410]: } May 11 11:19:38 volumio volumio[12410]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 11:19:38 volumio sudo[12988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-11 11:18 May 11 11:19:38 volumio sudo[12988]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 12:21:23 PM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a9588e47e4b05f1a05bf70b4acc7555c"