-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2025-05-18 11:18:57 CST. --
May 18 11:17:04 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 18 11:17:04 volumio volumio[32561]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
May 18 11:17:04 volumio volumio[32561]: info: CoreCommandRouter::volumioGetState
May 18 11:17:04 volumio volumio[32561]: info: CorePlayQueue::getTrack 0
May 18 11:17:09 volumio volumio[32561]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 18 11:17:09 volumio volumio[32561]: info: Preload queue cleared
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::volumioReplaceandPlayItems
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::ClearQueue
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::stop
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::setConsumeUpdateService undefined
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::clearPlayQueue
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::saveQueue
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::volumioPushQueue
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::addQueueItems
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::addQueueItems
May 18 11:17:09 volumio volumio[32561]: info: Preload queue cleared
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/莫文蔚-打起手鼓唱起æŒ.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/莫文蔚-打起手鼓唱起æŒ.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/程ç³-童年的å°æ‘‡è½¦.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/程ç³-童年的å°æ‘‡è½¦.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/çˆ±ä½ åœ¨å¿ƒå£éš¾å¼€.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/çˆ±ä½ åœ¨å¿ƒå£éš¾å¼€.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/A001.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/A001.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/A002.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/A002.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/B001.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/B001.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/B002.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/B002.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/故乡情.MP3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/故乡情.MP3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/乌兰托娅-套马æ†.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/乌兰托娅-套马æ†.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/å½ä¸½åª›-英雄赞æŒ.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/å½ä¸½åª›-英雄赞æŒ.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::volumioGetBrowseSources
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%E8%8E%AB%E6%96%87%E8%94%9A//extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E8%8E%AB%E6%96%87%E8%94%9A-%E6%89%93%E8%B5%B7%E6%89%8B%E9%BC%93%E5%94%B1%E8%B5%B7%E6%AD%8C.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/莫文蔚-打起手鼓唱起æŒ.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%C2%B3%C3%8C%C3%81%C3%95/20%C3%8A%C3%80%C2%BC%C3%8D%C3%96%C3%90%C2%BB%C2%AA%C2%B8%C3%A8%C3%8C%C2%B3%C3%83%C3%BB%C3%88%C3%8B%C2%B0%C3%99%C2%BC%C2%AF%C3%95%C3%A4%C2%B2%C3%98%C2%B0%C3%A6(%C2%B3%C3%8C%C3%81%C3%95)/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E7%A8%8B%E7%90%B3-%E7%AB%A5%E5%B9%B4%E7%9A%84%E5%B0%8F%E6%91%87%E8%BD%A6.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/程ç³-童年的å°æ‘‡è½¦.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%C3%83%C3%8E%C3%96%C2%AE%C3%82%C3%83/%C3%84%C3%BE%C2%B2%C2%A8%C2%BD%C2%AD%C3%93%C3%B1%C3%80%C3%89%C3%8A%C3%95%C2%B2%C3%98/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E7%88%B1%E4%BD%A0%E5%9C%A8%E5%BF%83%E5%8F%A3%E9%9A%BE%E5%BC%80.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/çˆ±ä½ åœ¨å¿ƒå£éš¾å¼€.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%C3%85%C2%B7%C3%91%C3%B4%C2%B7%C3%86%C2%B7%C3%86/%C3%8C%C3%B8%C2%B6%C2%AF72-A01/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2FA001.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/A001.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%C3%85%C2%B7%C3%91%C3%B4%C2%B7%C3%86%C2%B7%C3%86/%C3%8C%C3%B8%C2%B6%C2%AF72-A02/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2FA002.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/A002.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%C3%85%C2%B7%C3%91%C3%B4%C2%B7%C3%86%C2%B7%C3%86/%C3%8C%C3%B8%C2%B6%C2%AF72-B01/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2FB001.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/B001.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%C3%85%C2%B7%C3%91%C3%B4%C2%B7%C3%86%C2%B7%C3%86/%C3%8C%C3%B8%C2%B6%C2%AF72-B02/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2FB002.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/B002.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%C2%B3%C3%8C%C3%81%C3%95/%C3%96%C3%90%C2%B9%C3%BA%C2%B8%C3%A8%C3%8C%C2%B3%C3%83%C3%B7%C3%90%C3%87%C2%BC%C2%AF/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E6%95%85%E4%B9%A1%E6%83%85.MP3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/故乡情.MP3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%E4%B9%8C%E5%85%B0%E6%89%98%E5%A8%85/%E5%B9%B8%E7%A6%8F%E5%A1%91%E6%96%99%E8%8A%B1/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E4%B9%8C%E5%85%B0%E6%89%98%E5%A8%85-%E5%A5%97%E9%A9%AC%E6%9D%86.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/乌兰托娅-套马æ†.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%E5%BD%AD%E4%B8%BD%E5%AA%9B/%E6%88%91%E7%9A%84%E5%A3%AB%E5%85%B5%E5%85%84%E5%BC%9F/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E5%BD%AD%E4%B8%BD%E5%AA%9B-%E8%8B%B1%E9%9B%84%E8%B5%9E%E6%AD%8C.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/å½ä¸½åª›-英雄赞æŒ.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%E6%96%AF%E7%90%B4%E6%A0%BC%E6%97%A5%E4%B9%90/%E6%96%B0%E4%B8%96%E7%BA%AA/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E6%96%AF%E7%90%B4%E6%A0%BC%E6%97%A5%E4%B9%90-%E5%B1%B1%E6%AD%8C%E5%A5%BD%E6%AF%94%E6%98%A5%E6%B1%9F%E6%B0%B4.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::volumioPushQueue
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::saveQueue
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::updateTrackBlock
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::getTrackBlock
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::volumioPlay
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::play index 10
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::setConsumeUpdateService undefined
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::addQueueItems
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::addQueueItems
May 18 11:17:09 volumio volumio[32561]: info: Preload queue cleared
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/xuni.mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/xuni.mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: Adding Item to queue: music-library/USB/559D-6D82/cd/陈明-æž•ç€ä½ çš„åå—å…¥çœ .mp3
May 18 11:17:09 volumio volumio[32561]: info: Exploding uri music-library/USB/559D-6D82/cd/陈明-æž•ç€ä½ çš„åå—å…¥çœ .mp3 in service mpd
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::stop
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::setConsumeUpdateService undefined
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::play index undefined
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::setConsumeUpdateService undefined
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::startPlaybackTimer
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::clearAddPlayTracks USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand stop
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%E5%8A%9E%E6%A1%8C%E4%BA%8C%E4%BA%BA%E7%BB%84/%E6%B0%B8%E8%BF%9C%E7%9A%84%E6%9C%8B%E5%8F%8B%5Bwww.albumsinfo.com%20%E8%87%B3%E7%88%B1%E9%9F%B3%E4%B9%90%E8%AE%BA%E5%9D%9B%5D/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2Fxuni.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/xuni.mp3
May 18 11:17:09 volumio volumio[32561]: info: ALBUMART /albumart?cacheid=981&web=%E9%99%88%E6%98%8E/%E7%BA%A2%E9%A2%9C%E7%9F%A5%E5%B7%B1/extralarge&path=%2Fmnt%2FUSB%2F559D-6D82%2Fcd%2F%E9%99%88%E6%98%8E-%E6%9E%95%E7%9D%80%E4%BD%A0%E7%9A%84%E5%90%8D%E5%AD%97%E5%85%A5%E7%9C%A0.mp3&metadata=false
May 18 11:17:09 volumio volumio[32561]: info: URI /mnt/USB/559D-6D82/cd/陈明-æž•ç€ä½ çš„åå—å…¥çœ .mp3
May 18 11:17:09 volumio volumio[32561]: info: sendMpdCommand stop took 10 milliseconds
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand clear
May 18 11:17:09 volumio volumio[32561]: info: CoreCommandRouter::volumioPushQueue
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::saveQueue
May 18 11:17:09 volumio volumio[32561]: info: CoreStateMachine::updateTrackBlock
May 18 11:17:09 volumio volumio[32561]: info: CorePlayQueue::getTrackBlock
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces system playlist update
May 18 11:17:09 volumio volumio[32561]: info: Ignoring MPD Status Update
May 18 11:17:09 volumio volumio[32561]: info: sendMpdCommand clear took 8 milliseconds
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand add "USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3"
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces system playlist update
May 18 11:17:09 volumio volumio[32561]: info: Ignoring MPD Status Update
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces system playlist update
May 18 11:17:09 volumio volumio[32561]: info: Ignoring MPD Status Update
May 18 11:17:09 volumio volumio[32561]: error: updateQueue error: null
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces system playlist update
May 18 11:17:09 volumio volumio[32561]: info: Ignoring MPD Status Update
May 18 11:17:09 volumio volumio[32561]: info: ------------------------------ 9ms
May 18 11:17:09 volumio volumio[32561]: info: sendMpdCommand add "USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3" took 8 milliseconds
May 18 11:17:09 volumio volumio[32561]: info: ------------------------------ 7ms
May 18 11:17:09 volumio volumio[32561]: info: ------------------------------ 6ms
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand play
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces system playlist update
May 18 11:17:09 volumio volumio[32561]: info: Ignoring MPD Status Update
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces system playlist update
May 18 11:17:09 volumio volumio[32561]: info: Ignoring MPD Status Update
May 18 11:17:09 volumio volumio[32561]: info: ------------------------------ 9ms
May 18 11:17:09 volumio volumio[32561]: info: sendMpdCommand play took 4 milliseconds
May 18 11:17:09 volumio volumio[32561]: info: ------------------------------ 3ms
May 18 11:17:09 volumio volumio[32561]: info: ------------------------------ 2ms
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces state update: player
May 18 11:17:09 volumio volumio[32561]: info: ControllerMpd::getState
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand status
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces state update: player
May 18 11:17:09 volumio volumio[32561]: info: ControllerMpd::getState
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand status
May 18 11:17:09 volumio volumio[32561]: info:
May 18 11:17:09 volumio volumio[32561]: ---------------------------- MPD announces state update: player
May 18 11:17:09 volumio volumio[32561]: info: ControllerMpd::getState
May 18 11:17:09 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand status
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand status took 137 milliseconds
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 11:17:10 volumio volumio[32561]: info:
May 18 11:17:10 volumio volumio[32561]: ---------------------------- MPD announces state update: player
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::getState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand status
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand status took 140 milliseconds
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand status took 139 milliseconds
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseTrackInfo
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::pushState
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::servicePushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"å±±æŒå¥½æ¯”春江水","artist":"æ–¯ç´æ ¼æ—¥ä¹","album":"新世纪","uri":"USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3","trackType":"mp3"}
May 18 11:17:10 volumio volumio[32561]: verbose: CURRENT POSITION 10
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState stateService play
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState currentStatus stop
May 18 11:17:10 volumio volumio[32561]: info: ------------------------------ 148ms
May 18 11:17:10 volumio volumio[32561]: info:
May 18 11:17:10 volumio volumio[32561]: ---------------------------- MPD announces state update: player
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::getState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand status
May 18 11:17:10 volumio volumio[32561]: info:
May 18 11:17:10 volumio volumio[32561]: ---------------------------- MPD announces state update: player
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::getState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand status
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand status took 9 milliseconds
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand playlistinfo took 7 milliseconds
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand playlistinfo took 7 milliseconds
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand status took 2 milliseconds
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand status took 1 milliseconds
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseTrackInfo
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseTrackInfo
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseState
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::pushState
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::servicePushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: verbose: STATE SERVICE {"status":"play","position":0,"seek":535,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"å±±æŒå¥½æ¯”春江水","artist":"æ–¯ç´æ ¼æ—¥ä¹","album":"新世纪","uri":"USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3","trackType":"mp3"}
May 18 11:17:10 volumio volumio[32561]: verbose: CURRENT POSITION 10
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState stateService play
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState currentStatus play
May 18 11:17:10 volumio volumio[32561]: info: Received an update from plugin. extracting info from payload
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::pushState
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::servicePushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: verbose: STATE SERVICE {"status":"play","position":0,"seek":603,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"å±±æŒå¥½æ¯”春江水","artist":"æ–¯ç´æ ¼æ—¥ä¹","album":"新世纪","uri":"USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3","trackType":"mp3"}
May 18 11:17:10 volumio volumio[32561]: verbose: CURRENT POSITION 10
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState stateService play
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState currentStatus play
May 18 11:17:10 volumio volumio[32561]: info: Received an update from plugin. extracting info from payload
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: ------------------------------ 174ms
May 18 11:17:10 volumio volumio[32561]: info: ------------------------------ 175ms
May 18 11:17:10 volumio volumio[32561]: info: sendMpdCommand playlistinfo took 33 milliseconds
May 18 11:17:10 volumio volumio[32561]: verbose: ControllerMpd::parseTrackInfo
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::pushState
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::servicePushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"å±±æŒå¥½æ¯”春江水","artist":"æ–¯ç´æ ¼æ—¥ä¹","album":"新世纪","uri":"USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3","trackType":"mp3"}
May 18 11:17:10 volumio volumio[32561]: verbose: CURRENT POSITION 10
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState stateService play
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState currentStatus play
May 18 11:17:10 volumio volumio[32561]: info: Received an update from plugin. extracting info from payload
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::pushState
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::servicePushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"å±±æŒå¥½æ¯”春江水","artist":"æ–¯ç´æ ¼æ—¥ä¹","album":"新世纪","uri":"USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3","trackType":"mp3"}
May 18 11:17:10 volumio volumio[32561]: verbose: CURRENT POSITION 10
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState stateService play
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState currentStatus play
May 18 11:17:10 volumio volumio[32561]: info: Received an update from plugin. extracting info from payload
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: ControllerMpd::pushState
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::servicePushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":234,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"å±±æŒå¥½æ¯”春江水","artist":"æ–¯ç´æ ¼æ—¥ä¹","album":"新世纪","uri":"USB/559D-6D82/cd/æ–¯ç´æ ¼æ—¥ä¹-å±±æŒå¥½æ¯”春江水.mp3","trackType":"mp3"}
May 18 11:17:10 volumio volumio[32561]: verbose: CURRENT POSITION 10
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState stateService play
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::syncState currentStatus play
May 18 11:17:10 volumio volumio[32561]: info: Received an update from plugin. extracting info from payload
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:10 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:10 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:10 volumio volumio[32561]: info: ------------------------------ 83ms
May 18 11:17:10 volumio volumio[32561]: info: ------------------------------ 77ms
May 18 11:17:10 volumio volumio[32561]: info: ------------------------------ 77ms
May 18 11:17:11 volumio volumio[32561]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 18 11:17:11 volumio volumio[32561]: info: Completed starting MyVolumio Plugin
May 18 11:17:11 volumio volumio[32561]: [Metrics] CommandRouter: 34s 574.99ms
May 18 11:17:11 volumio volumio[32561]: info: CoreCommandRouter::volumiosetStartupVolume
May 18 11:17:11 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 18 11:17:11 volumio volumio[32561]: info: VolumeController:: Setting startup Volume 90
May 18 11:17:11 volumio volumio[32561]: info: VolumeController::SetAlsaVolume90
May 18 11:17:11 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 18 11:17:11 volumio volumio[32561]: info: CoreCommandRouter::Close All Modals sent
May 18 11:17:11 volumio volumio[32561]: info: CoreCommandRouter::Close All Modals sent
May 18 11:17:11 volumio volumio[32561]: info: CoreStateMachine::pushState
May 18 11:17:11 volumio volumio[32561]: info: CorePlayQueue::getTrack 10
May 18 11:17:11 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 18 11:17:11 volumio volumio[32561]: info: CoreCommandRouter::volumioPushState
May 18 11:17:11 volumio volumio[32561]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
May 18 11:17:11 volumio volumio[32561]: aplay: main:828: audio open error: Device or resource busy
May 18 11:17:12 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 18 11:17:12 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 18 11:17:12 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 18 11:17:18 volumio volumio[32561]: info: BOOT COMPLETED
May 18 11:17:51 volumio volumio-remote-updater[755]: No test mode
May 18 11:17:51 volumio volumio-remote-updater[755]: No alpha test mode
May 18 11:17:51 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
May 18 11:17:52 volumio volumio[32561]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Various Fixes for QOBUZ Connect
\n
\nNEW ADDITIONS
\n\n- Qobuz Connect Ready
\n
\n","title":"Update v3.812","updateavailable":true}
May 18 11:17:52 volumio volumio[32561]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
May 18 11:18:57 volumio volumio[32561]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 18 11:18:57 volumio volumio[32561]: Error: connect ETIMEDOUT 108.160.163.116:80
May 18 11:18:57 volumio volumio[32561]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
May 18 11:18:57 volumio volumio[32561]: errno: -110,
May 18 11:18:57 volumio volumio[32561]: code: 'ETIMEDOUT',
May 18 11:18:57 volumio volumio[32561]: syscall: 'connect',
May 18 11:18:57 volumio volumio[32561]: address: '108.160.163.116',
May 18 11:18:57 volumio volumio[32561]: port: 80
May 18 11:18:57 volumio volumio[32561]: }
May 18 11:18:57 volumio volumio[32561]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 18 11:18:57 volumio sudo[710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-18 11:17
May 18 11:18:57 volumio sudo[710]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"