-- Logs begin at Sat 2024-05-11 23:39:54 CST, end at Sun 2024-05-12 09:00:13 CST. -- May 12 08:59:00 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 08:59:00 volumio volumio[610]: info: Received Get System Info May 12 08:59:00 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 08:59:00 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 08:59:00 volumio volumio[610]: info: Discovery: Getting this device information May 12 08:59:00 volumio volumio[610]: info: CoreCommandRouter::volumioGetState May 12 08:59:00 volumio volumio[610]: info: CorePlayQueue::getTrack 1 May 12 08:59:00 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 08:59:03 volumio volumio[610]: info: Preload queue cleared May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioReplaceandPlayItems May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::ClearQueue May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::stop May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::stPlaybackTimer May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::updateTrackBlock May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrackBlock May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 1 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::serviceStop May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 1 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::serviceStop May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::stop May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand stop May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::clearPlayQueue May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::saveQueue May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushQueue May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::addQueueItems May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::addQueueItems May 12 08:59:03 volumio volumio[610]: info: Preload queue cleared May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/01.加州旅馆（老鹰乐队.动态现场感）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/01.加州旅馆（老鹰乐队.动态现场感）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/02.弥撒（低音大动态） .wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/02.弥撒（低音大动态） .wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/04.给月亮上颜色（德国老虎鱼推荐男中音）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/04.给月亮上颜色（德国老虎鱼推荐男中音）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/05.悲情城市（爆棚超低音）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/05.悲情城市（爆棚超低音）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/06.美人鱼之歌（醇美人声）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/06.美人鱼之歌（醇美人声）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/07.机遇Ⅰ（蔡琴宁静人声）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/07.机遇Ⅰ（蔡琴宁静人声）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/08.让我们荡起双桨（绝美合声）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/08.让我们荡起双桨（绝美合声）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/09.阿姐鼓（震撼动态）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/09.阿姐鼓（震撼动态）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/10.花儿与少年（人声）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/10.花儿与少年（人声）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/11.濑柳小镇（醇厚吉它）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/11.濑柳小镇（醇厚吉它）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/12.葬心（女声经典）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/12.葬心（女声经典）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/13.都市日出（超爽配乐）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/13.都市日出（超爽配乐）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/14.闲云孤鹤（浓密超重低音）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/14.闲云孤鹤（浓密超重低音）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/15.我只是一个乡村男孩（当·威廉姆斯）.wav May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/15.我只是一个乡村男孩（当·威廉姆斯）.wav May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/playlist.m3u May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/playlist.m3u May 12 08:59:03 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/播放列表.m3u May 12 08:59:03 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/播放列表.m3u May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushQueue May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::saveQueue May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::updateTrackBlock May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrackBlock May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPlay May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::play index 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::stop May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::play index undefined May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::startPlaybackTimer May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::clearAddPlayTracks NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand stop May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand stop took 14 milliseconds May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand stop took 2 milliseconds May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand clear May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:03 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 3 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand clear took 2 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 2 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 1 milliseconds May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand add "NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav" May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: 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} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService stop May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus stop May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: No code May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: 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} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService stop May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus stop May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: No code May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 9ms May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 9ms May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:03 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:03 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:03 volumio volumio[610]: error: updateQueue error: null May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:03 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 20ms May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand playlistinfo took 19 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand add "NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav" took 19 milliseconds May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 11ms May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 1ms May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand play May 12 08:59:03 volumio volumio[610]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 23ms May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:03 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:03 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 6ms May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand play took 5 milliseconds May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 5ms May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 4ms May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 29 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 28 milliseconds May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 14 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand playlistinfo took 14 milliseconds May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.人约黄昏后(人声).wav","artist":null,"album":null,"uri":"NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav","trackType":"wav"} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus stop May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.人约黄昏后(人声).wav","artist":null,"album":null,"uri":"NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav","trackType":"wav"} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:03 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 49ms May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 52ms May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: May 12 08:59:03 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand playlistinfo took 29 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand playlistinfo took 15 milliseconds May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.人约黄昏后(人声).wav","artist":null,"album":null,"uri":"NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav","trackType":"wav"} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:03 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.人约黄昏后(人声).wav","artist":null,"album":null,"uri":"NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav","trackType":"wav"} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:03 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 75ms May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 47ms May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 24 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand status took 26 milliseconds May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand playlistinfo took 77 milliseconds May 12 08:59:03 volumio volumio[610]: info: sendMpdCommand playlistinfo took 77 milliseconds May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:03 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":432,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.人约黄昏后(人声).wav","artist":null,"album":null,"uri":"NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav","trackType":"wav"} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:03 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":432,"duration":182,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"03.人约黄昏后(人声).wav","artist":null,"album":null,"uri":"NAS/2/老冯音乐/02 微信Linxp1975美丽厦门发烧碟本店私藏试音曲15首/03.人约黄昏后(人声).wav","trackType":"wav"} May 12 08:59:03 volumio volumio[610]: verbose: CURRENT POSITION 2 May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:03 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:03 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:03 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 131ms May 12 08:59:03 volumio volumio[610]: info: ------------------------------ 131ms May 12 08:59:18 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 12 08:59:18 volumio volumio[610]: info: CURURI: music-library May 12 08:59:18 volumio volumio[610]: info: Preload queue cleared May 12 08:59:19 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 12 08:59:19 volumio volumio[610]: info: CURURI: music-library/NAS May 12 08:59:19 volumio volumio[610]: info: Preload queue cleared May 12 08:59:19 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 12 08:59:19 volumio volumio[610]: info: CURURI: music-library/NAS/2 May 12 08:59:19 volumio volumio[610]: info: Preload queue cleared May 12 08:59:38 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 12 08:59:38 volumio volumio[610]: info: CURURI: music-library/NAS/2/12首无损煲机音乐 May 12 08:59:38 volumio volumio[610]: info: Preload queue cleared May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/05 天堂.ape May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/07 鼓诗.ape May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/08 闲云孤鹤.ape May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/10 加州旅馆.ape May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/11 The Mass.ape May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/06 渡口.wav May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/03 十面埋伏（琵琶版）.flac May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/01 Le Autunno Allegro.flac May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/12 Fairytale.flac May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/09 重返大峡谷.flac May 12 08:59:38 volumio volumio[610]: info: Preloading song: music-library/NAS/2/12首无损煲机音乐/04 青藏高原.flac May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=%E7%BA%AF%E9%9F%B3%E4%B9%90//extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F02%20%E6%A2%81%E7%A5%9D(%E5%B0%8F%E6%8F%90%E7%90%B4%E7%89%88).ape&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/05 天堂.ape in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=//extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F05%20%E5%A4%A9%E5%A0%82.ape&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/05 天堂.ape May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/07 鼓诗.ape in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=//extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F07%20%E9%BC%93%E8%AF%97.ape&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/07 鼓诗.ape May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/08 闲云孤鹤.ape in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=//extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F08%20%E9%97%B2%E4%BA%91%E5%AD%A4%E9%B9%A4.ape&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/08 闲云孤鹤.ape May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/10 加州旅馆.ape in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=//extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F10%20%E5%8A%A0%E5%B7%9E%E6%97%85%E9%A6%86.ape&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/10 加州旅馆.ape May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/11 The Mass.ape in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=//extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F11%20The%20Mass.ape&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/11 The Mass.ape May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/06 渡口.wav in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=%5B51ape.com%5D%3F%3F/%3F%3F%20%3F%3F/extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F06%20%E6%B8%A1%E5%8F%A3.wav&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/06 渡口.wav May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/03 十面埋伏（琵琶版）.flac in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=Zhang%20Hong%20Yan/Ambush%20On%20All%20Sides/extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F03%20%E5%8D%81%E9%9D%A2%E5%9F%8B%E4%BC%8F%EF%BC%88%E7%90%B5%E7%90%B6%E7%89%88%EF%BC%89.flac&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/03 十面埋伏（琵琶版）.flac May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/01 Le Autunno Allegro.flac in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=Sonatori%20de%20la%20gioiosa%20marca/Antonio%20Vivaldi%20La%20Quattro%20Stagioni/extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F01%20Le%20Autunno%20Allegro.flac&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/01 Le Autunno Allegro.flac May 12 08:59:38 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/12 Fairytale.flac in service mpd May 12 08:59:38 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=Secret%20Garden%20%E7%A5%9E%E7%A7%98%E5%9B%AD/Once%20In%20A%20Red%20Moon%20%E5%BF%86%E6%B8%B8%E7%BA%A2%E6%9C%88/extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F12%20Fairytale.flac&metadata=false May 12 08:59:38 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/12 Fairytale.flac May 12 08:59:39 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/09 重返大峡谷.flac in service mpd May 12 08:59:39 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=/%E7%A3%A8%E5%9D%8A%E9%AB%98%E5%93%81%E8%B4%A8%E9%9F%B3%E4%B9%90%E8%AE%BA%E5%9D%9B-MOOFEEL.COM/extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F09%20%E9%87%8D%E8%BF%94%E5%A4%A7%E5%B3%A1%E8%B0%B7.flac&metadata=false May 12 08:59:39 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/09 重返大峡谷.flac May 12 08:59:39 volumio volumio[610]: info: Exploding uri music-library/NAS/2/12首无损煲机音乐/04 青藏高原.flac in service mpd May 12 08:59:39 volumio volumio[610]: info: ALBUMART /albumart?cacheid=853&web=%E6%9D%8E%E5%A8%9C/%E9%9D%92%E8%97%8F%E9%AB%98%E5%8E%9F/extralarge&path=%2Fmnt%2FNAS%2F2%2F12%E9%A6%96%E6%97%A0%E6%8D%9F%E7%85%B2%E6%9C%BA%E9%9F%B3%E4%B9%90%2F04%20%E9%9D%92%E8%97%8F%E9%AB%98%E5%8E%9F.flac&metadata=false May 12 08:59:39 volumio volumio[610]: info: URI /mnt/NAS/2/12首无损煲机音乐/04 青藏高原.flac May 12 08:59:45 volumio volumio[610]: info: Preload queue cleared May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioReplaceandPlayItems May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::ClearQueue May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::stop May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::stPlaybackTimer May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::updateTrackBlock May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrackBlock May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::serviceStop May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 2 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::serviceStop May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::stop May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand stop May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::clearPlayQueue May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::saveQueue May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushQueue May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::addQueueItems May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::addQueueItems May 12 08:59:45 volumio volumio[610]: info: Preload queue cleared May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/05 天堂.ape May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/05 天堂.ape May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/07 鼓诗.ape May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/07 鼓诗.ape May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/08 闲云孤鹤.ape May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/08 闲云孤鹤.ape May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/10 加州旅馆.ape May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/10 加州旅馆.ape May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/11 The Mass.ape May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/11 The Mass.ape May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/06 渡口.wav May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/06 渡口.wav May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/03 十面埋伏（琵琶版）.flac May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/03 十面埋伏（琵琶版）.flac May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/01 Le Autunno Allegro.flac May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/01 Le Autunno Allegro.flac May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/12 Fairytale.flac May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/12 Fairytale.flac May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/09 重返大峡谷.flac May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/09 重返大峡谷.flac May 12 08:59:45 volumio volumio[610]: info: Adding Item to queue: music-library/NAS/2/12首无损煲机音乐/04 青藏高原.flac May 12 08:59:45 volumio volumio[610]: info: Using cached record of: music-library/NAS/2/12首无损煲机音乐/04 青藏高原.flac May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushQueue May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::saveQueue May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::updateTrackBlock May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrackBlock May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPlay May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::play index 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::stop May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::play index undefined May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::startPlaybackTimer May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::clearAddPlayTracks NAS/2/12首无损煲机音乐/04 青藏高原.flac May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand stop May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand stop took 10 milliseconds May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand stop took 2 milliseconds May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand clear May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:45 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand status took 3 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand clear took 3 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand status took 2 milliseconds May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand add "NAS/2/12首无损煲机音乐/04 青藏高原.flac" May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: 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} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService stop May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus stop May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: No code May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: 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} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService stop May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus stop May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: No code May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 10ms May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 10ms May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:45 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:45 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:45 volumio volumio[610]: error: updateQueue error: null May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:45 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 13ms May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand playlistinfo took 12 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand add "NAS/2/12首无损煲机音乐/04 青藏高原.flac" took 12 milliseconds May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 3ms May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 4ms May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand play May 12 08:59:45 volumio volumio[610]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 16ms May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:45 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces system playlist update May 12 08:59:45 volumio volumio[610]: info: Ignoring MPD Status Update May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 4ms May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand play took 3 milliseconds May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 3ms May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand status took 12 milliseconds May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: May 12 08:59:45 volumio volumio[610]: ---------------------------- MPD announces state update: player May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::getState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand status May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand status took 6 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand playlistinfo took 6 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand playlistinfo took 6 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand playlistinfo took 6 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand status took 5 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand status took 4 milliseconds May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseState May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"青藏高原","artist":"李娜","album":"青藏高原","uri":"NAS/2/12首无损煲机音乐/04 青藏高原.flac","trackType":"flac"} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus stop May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"青藏高原","artist":"李娜","album":"青藏高原","uri":"NAS/2/12首无损煲机音乐/04 青藏高原.flac","trackType":"flac"} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:45 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"青藏高原","artist":"李娜","album":"青藏高原","uri":"NAS/2/12首无损煲机音乐/04 青藏高原.flac","trackType":"flac"} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:45 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 29ms May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 32ms May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 34ms May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand playlistinfo took 16 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand playlistinfo took 14 milliseconds May 12 08:59:45 volumio volumio[610]: info: sendMpdCommand playlistinfo took 15 milliseconds May 12 08:59:45 volumio volumio[610]: verbose: ControllerMpd::parseTrackInfo May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":318,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"青藏高原","artist":"李娜","album":"青藏高原","uri":"NAS/2/12首无损煲机音乐/04 青藏高原.flac","trackType":"flac"} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:45 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":318,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"青藏高原","artist":"李娜","album":"青藏高原","uri":"NAS/2/12首无损煲机音乐/04 青藏高原.flac","trackType":"flac"} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:45 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: ControllerMpd::pushState May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::servicePushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: verbose: STATE SERVICE {"status":"play","position":0,"seek":318,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"96 Kbps","isStreaming":false,"title":"青藏高原","artist":"李娜","album":"青藏高原","uri":"NAS/2/12首无损煲机音乐/04 青藏高原.flac","trackType":"flac"} May 12 08:59:45 volumio volumio[610]: verbose: CURRENT POSITION 11 May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState stateService play May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::syncState currentStatus play May 12 08:59:45 volumio volumio[610]: info: Received an update from plugin. extracting info from payload May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: CoreStateMachine::pushState May 12 08:59:45 volumio volumio[610]: info: CorePlayQueue::getTrack 11 May 12 08:59:45 volumio volumio[610]: info: CoreCommandRouter::volumioPushState May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 45ms May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 46ms May 12 08:59:45 volumio volumio[610]: info: ------------------------------ 44ms May 12 08:59:56 volumio volumio[610]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 08:59:56 volumio volumio[610]: Error: connect ECONNREFUSED 185.45.6.57:443 May 12 08:59:56 volumio volumio[610]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 12 08:59:56 volumio volumio[610]: errno: -111, May 12 08:59:56 volumio volumio[610]: code: 'ECONNREFUSED', May 12 08:59:56 volumio volumio[610]: syscall: 'connect', May 12 08:59:56 volumio volumio[610]: address: '185.45.6.57', May 12 08:59:56 volumio volumio[610]: port: 443 May 12 08:59:56 volumio volumio[610]: } May 12 08:59:56 volumio volumio[610]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 08:59:56 volumio sudo[29932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 08:58 May 12 08:59:56 volumio sudo[29932]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 08:59:56 volumio sudo[29932]: pam_unix(sudo:session): session closed for user root May 12 09:00:04 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 12 09:00:04 volumio volumio-remote-updater[463]: [2024-05-12 09:00:04] [info] asio async_read_at_least error: system:104 (Connection reset by peer) May 12 09:00:04 volumio volumio-remote-updater[463]: [2024-05-12 09:00:04] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) May 12 09:00:04 volumio volumio-remote-updater[463]: [2024-05-12 09:00:04] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] May 12 09:00:04 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 12 09:00:04 volumio systemd[1]: Started dynamicswap service. May 12 09:00:04 volumio systemd[1]: dynamicswap.service: Succeeded. May 12 09:00:04 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 12 09:00:04 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. May 12 09:00:04 volumio systemd[1]: Stopped Volumio Backend Module. May 12 09:00:04 volumio systemd[1]: Started Volumio Backend Module. May 12 09:00:04 volumio systemd[1]: Started dynamicswap service. May 12 09:00:04 volumio systemd[1]: dynamicswap.service: Succeeded. May 12 09:00:05 volumio volumio[29946]: info: ------------------------------------------- May 12 09:00:05 volumio volumio[29946]: info: ----- Volumio3 ---- May 12 09:00:05 volumio volumio[29946]: info: ------------------------------------------- May 12 09:00:05 volumio volumio[29946]: info: ----- System startup ---- May 12 09:00:05 volumio volumio[29946]: info: ------------------------------------------- May 12 09:00:05 volumio volumio[29946]: info: MYVOLUMIO Environment detected May 12 09:00:05 volumio volumio[29946]: info: Plugin folders cleanup May 12 09:00:05 volumio volumio[29946]: info: Scanning into folder /volumio/app/plugins/ May 12 09:00:05 volumio volumio[29946]: info: Scanning category audio_interface May 12 09:00:05 volumio volumio[29946]: info: Scanning category miscellanea May 12 09:00:05 volumio volumio[29946]: info: Scanning category music_service May 12 09:00:05 volumio volumio[29946]: info: Scanning category plugins.json May 12 09:00:05 volumio volumio[29946]: info: Scanning category system_controller May 12 09:00:05 volumio volumio[29946]: info: Scanning category user_interface May 12 09:00:05 volumio volumio[29946]: info: Scanning into folder /data/plugins/ May 12 09:00:05 volumio volumio[29946]: info: Plugin folders cleanup completed May 12 09:00:05 volumio volumio[29946]: info: ------------------------------------------- May 12 09:00:05 volumio volumio[29946]: info: ----- Core plugins startup ---- May 12 09:00:05 volumio volumio[29946]: info: ------------------------------------------- May 12 09:00:05 volumio volumio[29946]: info: Loading plugins from folder /volumio/app/plugins/ May 12 09:00:05 volumio volumio[29946]: info: Adding plugin upnp to MyMusic Plugins May 12 09:00:05 volumio volumio[29946]: info: Adding plugin airplay_emulation to MyMusic Plugins May 12 09:00:05 volumio volumio[29946]: info: Adding plugin upnp_browser to MyMusic Plugins May 12 09:00:05 volumio volumio[29946]: info: Loading plugins from folder /data/plugins/ May 12 09:00:05 volumio volumio[29946]: info: Loading plugin "system"... May 12 09:00:05 volumio volumio[29946]: info: Loading plugin "appearance"... May 12 09:00:05 volumio volumio[29946]: info: Loading plugin "network"... May 12 09:00:05 volumio volumio[29946]: info: Refreshing Cached IP Addresses May 12 09:00:05 volumio sudo[29974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 09:00:05 volumio sudo[29974]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "services"... May 12 09:00:06 volumio sudo[29976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "alsa_controller"... May 12 09:00:06 volumio sudo[29974]: pam_unix(sudo:session): session closed for user root May 12 09:00:06 volumio sudo[29976]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio sudo[29978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 12 09:00:06 volumio sudo[29978]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio sudo[29976]: pam_unix(sudo:session): session closed for user root May 12 09:00:06 volumio sudo[29978]: pam_unix(sudo:session): session closed for user root May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "wizard"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "networkfs"... May 12 09:00:06 volumio volumio[29946]: info: Cannot mount NAS 2 at system boot, trial number 1 ,retrying in 5 seconds May 12 09:00:06 volumio volumio[29946]: info: Starting Udev Watcher for removable devices May 12 09:00:06 volumio volumio[29946]: info: Ignoring mount for partition: boot May 12 09:00:06 volumio volumio[29946]: info: Ignoring mount for partition: volumio May 12 09:00:06 volumio volumio[29946]: info: Ignoring mount for partition: volumio_data May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "volumio_command_line_client"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "upnp"... May 12 09:00:06 volumio volumio[29946]: info: [1715475606173] Starting Upmpd Daemon May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "my_music"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "mpd"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "upnp_browser"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "alarm-clock"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "airplay_emulation"... May 12 09:00:06 volumio volumio[29946]: info: Starting Shairport Sync May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "last_100"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "webradio"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "i2s_dacs"... May 12 09:00:06 volumio volumio[29946]: info: I2S DAC not set, start Auto-detection May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "volumiodiscovery"... May 12 09:00:06 volumio volumio[29946]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 12 09:00:06 volumio volumio[29946]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 09:00:06 volumio volumio[29946]: *** WARNING *** For more information see May 12 09:00:06 volumio volumio[29946]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 12 09:00:06 volumio volumio[29946]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 09:00:06 volumio node[29946]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 12 09:00:06 volumio volumio[29946]: *** WARNING *** For more information see May 12 09:00:06 volumio node[29946]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 09:00:06 volumio node[29946]: *** WARNING *** For more information see May 12 09:00:06 volumio node[29946]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 12 09:00:06 volumio node[29946]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 09:00:06 volumio node[29946]: *** WARNING *** For more information see May 12 09:00:06 volumio volumio[29946]: info: Applying required configuration parameters for plugin volumiodiscovery May 12 09:00:06 volumio volumio[29946]: info: Discovery: Started advertising with name: Volumio May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "outputs"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "albumart"... May 12 09:00:06 volumio volumio[29946]: info: Plugin example_plugin is not enabled May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "inputs"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "updater_comm"... May 12 09:00:06 volumio volumio[29946]: Forking 1 albumart workers May 12 09:00:06 volumio volumio[29946]: info: Plugin mpdemulation is not enabled May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "rest_api"... May 12 09:00:06 volumio volumio[29946]: info: Loading plugin "websocket"... May 12 09:00:06 volumio volumio[29946]: info: Loading i18n strings for locale zh May 12 09:00:06 volumio volumio[29946]: Updating browse sources language May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::initPlayerControls May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 09:00:06 volumio volumio[29946]: Express server listening on port 3000 May 12 09:00:06 volumio volumio[29946]: [Metrics] WebUI: 1s 573.62ms May 12 09:00:06 volumio volumio[29946]: info: Setting Device type: x86 May 12 09:00:06 volumio volumio[29946]: info: CoreStateMachine::resetVolumioState May 12 09:00:06 volumio volumio[29946]: info: CoreStateMachine::getcurrentVolume May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::volumioRetrievevolume May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 09:00:06 volumio volumio[29946]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 12 09:00:06 volumio volumio[29946]: info: Completed loading Core Plugins May 12 09:00:06 volumio volumio[29946]: info: Preparing to generate the ALSA configuration file May 12 09:00:06 volumio volumio[29946]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 12 09:00:06 volumio volumio[29946]: wlan0 Interface doesn't support scanning. May 12 09:00:06 volumio volumio[29946]: info: Cannot use regular scanning, forcing with ap-force May 12 09:00:06 volumio sudo[30009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 12 09:00:06 volumio sudo[30009]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio volumio[29946]: Starting albumart workers May 12 09:00:06 volumio sudo[30009]: pam_unix(sudo:session): session closed for user root May 12 09:00:06 volumio volumio[29946]: command failed: No such device (-19) May 12 09:00:06 volumio volumio[29946]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 12 09:00:06 volumio volumio[29946]: command failed: No such device (-19) May 12 09:00:06 volumio volumio[29946]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 12 09:00:06 volumio volumio[29946]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 1 May 12 09:00:06 volumio volumio[29946]: verbose: New Socket.io Connection to 192.168.100.27 from 192.168.100.4 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 EdgA/124.0.0.0 Total Clients: 2 May 12 09:00:06 volumio volumio[29946]: info: Reloading queue from file May 12 09:00:06 volumio volumio[29946]: info: Asound.conf file unchanged, so no further update is needed May 12 09:00:06 volumio volumio[29946]: info: Output device has changed, restarting MPD May 12 09:00:06 volumio volumio[29946]: info: Output device has changed, restarting Shairport Sync May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 09:00:06 volumio sudo[30020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 09:00:06 volumio sudo[30020]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio sudo[30020]: pam_unix(sudo:session): session closed for user root May 12 09:00:06 volumio sudo[30021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 09:00:06 volumio sudo[30021]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio volumio[29946]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 09:00:06 volumio systemd[1]: Stopping Music Player Daemon... May 12 09:00:06 volumio volumio[29946]: info: ___________ START PLUGINS ___________ May 12 09:00:06 volumio volumio[29946]: info: ControllerMpd::onStart: Initializing MPD May 12 09:00:06 volumio volumio[29946]: info: Creating MPD Configuration file May 12 09:00:06 volumio sudo[30036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 09:00:06 volumio sudo[30036]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio sudo[30036]: pam_unix(sudo:session): session closed for user root May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 09:00:06 volumio volumio[29946]: info: [1715475606928] CoreMusicLibrary::Adding element 媒体服务器 May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 09:00:06 volumio sudo[30039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 09:00:06 volumio sudo[30039]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:06 volumio volumio[29946]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 09:00:06 volumio volumio[29946]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 09:00:06 volumio volumio[29946]: info: [1715475606991] CoreMusicLibrary::Adding element Last_100 May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 09:00:06 volumio volumio[29946]: info: [1715475606992] CoreMusicLibrary::Adding element Webradio May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 09:00:06 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 09:00:06 volumio volumio[29946]: info: Volumio Calling Home May 12 09:00:07 volumio volumio[29946]: info: CoreStateMachine::setRepeat true single undefined May 12 09:00:07 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:07 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:07 volumio volumio[29946]: info: CoreStateMachine::setRandom null May 12 09:00:07 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:07 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:07 volumio volumio[29946]: info: VolumeController:: Volume=0 Mute =false May 12 09:00:07 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:07 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:07 volumio volumio[29946]: info: CoreStateMachine::updateTrackBlock May 12 09:00:07 volumio volumio[29946]: info: CorePlayQueue::getTrackBlock May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::volumioRetrievevolume May 12 09:00:07 volumio volumio[29946]: info: MPD Permissions set May 12 09:00:07 volumio volumio[29946]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 09:00:07 volumio volumio[29946]: info: Starting Shairport Sync May 12 09:00:07 volumio volumio[29946]: info: Starting Shairport Sync May 12 09:00:07 volumio sudo[30065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 09:00:07 volumio volumio[29946]: info: Starting Shairport Sync May 12 09:00:07 volumio sudo[30065]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:07 volumio sudo[30067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 09:00:07 volumio sudo[30067]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:07 volumio volumio[29946]: info: VolumeController:: Volume=0 Mute =false May 12 09:00:07 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:07 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:07 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 09:00:07 volumio sudo[30071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 09:00:07 volumio sudo[30071]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 09:00:07 volumio systemd[1]: shairport-sync.service: Succeeded. May 12 09:00:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 09:00:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 09:00:07 volumio sudo[30067]: pam_unix(sudo:session): session closed for user root May 12 09:00:07 volumio sudo[30065]: pam_unix(sudo:session): session closed for user root May 12 09:00:07 volumio sudo[30071]: pam_unix(sudo:session): session closed for user root May 12 09:00:07 volumio volumio[29946]: info: Shairport-Sync Started May 12 09:00:07 volumio volumio[29946]: Error adding Membership: Error: addMembership EINVAL May 12 09:00:07 volumio volumio[29946]: info: Shairport-Sync Started May 12 09:00:07 volumio volumio[29946]: info: Shairport-Sync Started May 12 09:00:07 volumio systemd[1]: mpd.service: Succeeded. May 12 09:00:07 volumio systemd[1]: Stopped Music Player Daemon. May 12 09:00:07 volumio systemd[1]: Starting Music Player Daemon... May 12 09:00:08 volumio volumio[29946]: verbose: New Socket.io Connection to 192.168.100.27 from 192.168.100.4 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Mobile Safari/537.36 EdgA/124.0.0.0 Total Clients: 4 May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetVisibleSources May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetQueue May 12 09:00:08 volumio volumio[29946]: info: CoreStateMachine::getQueue May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getQueue May 12 09:00:08 volumio volumio[29946]: info: Listing playlists May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 09:00:08 volumio volumio[29946]: info: Received Get System Info May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 09:00:08 volumio volumio[29946]: info: Discovery: Getting this device information May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:08 volumio mpd[30077]: May 12 09:00 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 12 09:00:08 volumio systemd[1]: Started Music Player Daemon. May 12 09:00:08 volumio sudo[30039]: pam_unix(sudo:session): session closed for user root May 12 09:00:08 volumio sudo[30021]: pam_unix(sudo:session): session closed for user root May 12 09:00:08 volumio volumio[29946]: info: Completed starting Core Plugins May 12 09:00:08 volumio volumio[29946]: info: ------------------------------------------- May 12 09:00:08 volumio volumio[29946]: info: ----- MyVolumio plugins startup ---- May 12 09:00:08 volumio volumio[29946]: info: ------------------------------------------- May 12 09:00:08 volumio volumio[29946]: info: [MyVolumio PluginManager] Fetching plans data.... May 12 09:00:08 volumio volumio[29946]: error: MPD error: The expression evaluated to a falsy value: May 12 09:00:08 volumio volumio[29946]: assert.ok(self.idling) May 12 09:00:08 volumio volumio[29946]: error: The expression evaluated to a falsy value: May 12 09:00:08 volumio volumio[29946]: assert.ok(self.idling) May 12 09:00:08 volumio volumio[29946]: info: MPD running with PID30077 May 12 09:00:08 volumio volumio[29946]: ,establishing connection May 12 09:00:08 volumio volumio[29946]: error: updateQueue error: null May 12 09:00:08 volumio volumio[29946]: error: updateQueue error: null May 12 09:00:08 volumio volumio[29946]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Total Clients: 5 May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetVisibleSources May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 09:00:08 volumio volumio[29946]: info: Received Get System Info May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 09:00:08 volumio volumio[29946]: info: Discovery: Getting this device information May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 09:00:08 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:08 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:08 volumio volumio[29946]: info: Listing playlists May 12 09:00:09 volumio volumio-remote-updater[463]: [2024-05-12 09:00:09] [connect] Successful connection May 12 09:00:09 volumio volumio[29946]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 6 May 12 09:00:09 volumio volumio-remote-updater[463]: [2024-05-12 09:00:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1715475609 101 May 12 09:00:11 volumio volumio[29946]: info: Cannot mount NAS 2 at system boot, trial number 2 ,retrying in 5 seconds May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioGetState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPlay May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::play index undefined May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::setConsumeUpdateService undefined May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::startPlaybackTimer May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::clearAddPlayTracks NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand stop May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand stop took 1 milliseconds May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand clear May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces system playlist update May 12 09:00:12 volumio volumio[29946]: info: Ignoring MPD Status Update May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand clear took 1 milliseconds May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand add "NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape" May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces system playlist update May 12 09:00:12 volumio volumio[29946]: info: Ignoring MPD Status Update May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces system playlist update May 12 09:00:12 volumio volumio[29946]: info: Ignoring MPD Status Update May 12 09:00:12 volumio volumio[29946]: error: updateQueue error: null May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces system playlist update May 12 09:00:12 volumio volumio[29946]: info: Ignoring MPD Status Update May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 3ms May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand add "NAS/2/12首无损煲机音乐/02 梁祝(小提琴版).ape" took 3 milliseconds May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 3ms May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 2ms May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand play May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces system playlist update May 12 09:00:12 volumio volumio[29946]: info: Ignoring MPD Status Update May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces system playlist update May 12 09:00:12 volumio volumio[29946]: info: Ignoring MPD Status Update May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 2ms May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand play took 1 milliseconds May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 2ms May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 1ms May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces state update: player May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::getState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand status May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces state update: player May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::getState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand status May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces state update: player May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::getState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand status May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces state update: player May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand status took 7 milliseconds May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::getState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand status May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces state update: player May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::getState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand status May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand status took 50 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand status took 50 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand status took 39 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand playlistinfo took 63 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand status took 63 milliseconds May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseTrackInfo May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::pushState May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::servicePushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"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/2/12首无损煲机音乐/02 梁祝(小提琴版).ape","trackType":"ape"} May 12 09:00:12 volumio volumio[29946]: verbose: CURRENT POSITION 0 May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState stateService play May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState currentStatus stop May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 94ms May 12 09:00:12 volumio volumio[29946]: info: May 12 09:00:12 volumio volumio[29946]: ---------------------------- MPD announces state update: player May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::getState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand status May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand playlistinfo took 9 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand playlistinfo took 8 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand playlistinfo took 9 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand playlistinfo took 7 milliseconds May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand status took 4 milliseconds May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseTrackInfo May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseState May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::pushState May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::servicePushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"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/2/12首无损煲机音乐/02 梁祝(小提琴版).ape","trackType":"ape"} May 12 09:00:12 volumio volumio[29946]: verbose: CURRENT POSITION 0 May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState stateService play May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState currentStatus play May 12 09:00:12 volumio volumio[29946]: info: Received an update from plugin. extracting info from payload May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::pushState May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::servicePushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"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/2/12首无损煲机音乐/02 梁祝(小提琴版).ape","trackType":"ape"} May 12 09:00:12 volumio volumio[29946]: verbose: CURRENT POSITION 0 May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState stateService play May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState currentStatus play May 12 09:00:12 volumio volumio[29946]: info: Received an update from plugin. extracting info from payload May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::pushState May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::servicePushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"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/2/12首无损煲机音乐/02 梁祝(小提琴版).ape","trackType":"ape"} May 12 09:00:12 volumio volumio[29946]: verbose: CURRENT POSITION 0 May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState stateService play May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState currentStatus play May 12 09:00:12 volumio volumio[29946]: info: Received an update from plugin. extracting info from payload May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::pushState May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::servicePushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"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/2/12首无损煲机音乐/02 梁祝(小提琴版).ape","trackType":"ape"} May 12 09:00:12 volumio volumio[29946]: verbose: CURRENT POSITION 0 May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState stateService play May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState currentStatus play May 12 09:00:12 volumio volumio[29946]: info: Received an update from plugin. extracting info from payload May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 192ms May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 186ms May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 230ms May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 219ms May 12 09:00:12 volumio volumio[29946]: info: sendMpdCommand playlistinfo took 150 milliseconds May 12 09:00:12 volumio volumio[29946]: verbose: ControllerMpd::parseTrackInfo May 12 09:00:12 volumio volumio[29946]: info: ControllerMpd::pushState May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::servicePushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: verbose: STATE SERVICE {"status":"play","position":0,"seek":387,"duration":184,"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/2/12首无损煲机音乐/02 梁祝(小提琴版).ape","trackType":"ape"} May 12 09:00:12 volumio volumio[29946]: verbose: CURRENT POSITION 0 May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState stateService play May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::syncState currentStatus play May 12 09:00:12 volumio volumio[29946]: info: Received an update from plugin. extracting info from payload May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: CoreStateMachine::pushState May 12 09:00:12 volumio volumio[29946]: info: CorePlayQueue::getTrack 0 May 12 09:00:12 volumio volumio[29946]: info: CoreCommandRouter::volumioPushState May 12 09:00:12 volumio volumio[29946]: info: ------------------------------ 167ms May 12 09:00:12 volumio volumio[29946]: info: Volumio called home May 12 09:00:13 volumio volumio[29946]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 09:00:13 volumio volumio[29946]: Error: connect ECONNREFUSED 185.45.6.57:80 May 12 09:00:13 volumio volumio[29946]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { May 12 09:00:13 volumio volumio[29946]: errno: -111, May 12 09:00:13 volumio volumio[29946]: code: 'ECONNREFUSED', May 12 09:00:13 volumio volumio[29946]: syscall: 'connect', May 12 09:00:13 volumio volumio[29946]: address: '185.45.6.57', May 12 09:00:13 volumio volumio[29946]: port: 80 May 12 09:00:13 volumio volumio[29946]: } May 12 09:00:13 volumio volumio[29946]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 09:00:13 volumio sudo[30099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-12 08:59 May 12 09:00:13 volumio sudo[30099]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"