-- Logs begin at Fri 2024-05-03 13:33:38 UTC, end at Fri 2025-06-20 12:01:31 UTC. -- Jun 20 12:00:38 volumio volumio[2725]: info: Jun 20 12:00:38 volumio volumio[2725]: ---------------------------- MPD announces state update: player Jun 20 12:00:38 volumio volumio[2725]: info: ControllerMpd::getState Jun 20 12:00:38 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand status Jun 20 12:00:38 volumio volumio[2725]: info: sendMpdCommand status took 2 milliseconds Jun 20 12:00:38 volumio volumio[2725]: verbose: ControllerMpd::parseState Jun 20 12:00:38 volumio volumio[2725]: info: ControllerMpd::pushState Jun 20 12:00:38 volumio volumio[2725]: info: CoreCommandRouter::servicePushState Jun 20 12:00:38 volumio volumio[2725]: info: CoreStateMachine::pushState Jun 20 12:00:38 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:00:38 volumio volumio[2725]: info: CoreCommandRouter::volumioPushState Jun 20 12:00:38 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 12:00:38 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:00:38 volumio volumio[2725]: 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} Jun 20 12:00:38 volumio volumio[2725]: verbose: CURRENT POSITION 0 Jun 20 12:00:38 volumio volumio[2725]: info: CoreStateMachine::syncState stateService stop Jun 20 12:00:38 volumio volumio[2725]: info: CoreStateMachine::syncState currentStatus stop Jun 20 12:00:38 volumio volumio[2725]: info: CoreStateMachine::pushState Jun 20 12:00:38 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:00:38 volumio volumio[2725]: info: CoreCommandRouter::volumioPushState Jun 20 12:00:38 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 12:00:38 volumio volumio[2725]: info: No code Jun 20 12:00:38 volumio volumio[2725]: info: CoreStateMachine::pushState Jun 20 12:00:38 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:00:38 volumio volumio[2725]: info: CoreCommandRouter::volumioPushState Jun 20 12:00:38 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 12:00:38 volumio volumio[2725]: info: ------------------------------ 20ms Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 12:00:57 volumio volumio[2725]: info: Discovery: Getting this device information Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::volumioGetState Jun 20 12:00:57 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 12:00:57 volumio volumio[2725]: info: Discovery: Getting this device information Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::volumioGetState Jun 20 12:00:57 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 20 12:00:57 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 20 12:00:57 volumio volumio[2725]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C2%BD%C3%9C/15c4bf4c-6ccd-4ad1-bc11-4fbcfb3e7ee9.jpg' Jun 20 12:00:57 volumio volumio[2725]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%B0%AD%E5%92%8F%E9%BA%9F/%E7%88%B1%E6%83%85%E9%99%B7%E9%98%B1/61d5b7c4-cc28-470a-b3b0-2e15bdf445a6.jpg' Jun 20 12:00:57 volumio volumio[2725]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%8F%A4%E5%B7%A8%E5%9F%BA/%E6%97%B6%E4%BB%A3/23755026-24e0-4b2c-bf67-7ee8bc91611b.jpg' Jun 20 12:00:57 volumio volumio[2725]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/RADWIMPS/%E5%90%9B%E3%81%AE%E5%90%8D%E3%81%AF%E3%80%82/d194db18-2bb3-46c9-9a1e-57f4f9946647.jpg' Jun 20 12:01:06 volumio volumio[2725]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%BE%A4%E6%98%9F/6cc62f59-5e81-4328-8c57-59a3cc5f8bf5.jpg' Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 12:01:16 volumio volumio[2725]: info: Discovery: Getting this device information Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::volumioGetState Jun 20 12:01:16 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::volumioGetState Jun 20 12:01:16 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 20 12:01:16 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 20 12:01:17 volumio volumio[2725]: info: CoreCommandRouter::volumioGetState Jun 20 12:01:17 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:01:17 volumio sudo[3223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 12:01:17 volumio sudo[3223]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 12:01:17 volumio sudo[3225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 12:01:17 volumio sudo[3223]: pam_unix(sudo:session): session closed for user root Jun 20 12:01:17 volumio sudo[3225]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 12:01:18 volumio sudo[3225]: pam_unix(sudo:session): session closed for user root Jun 20 12:01:18 volumio sudo[3241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 12:01:18 volumio sudo[3241]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 12:01:18 volumio sudo[3243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 12:01:18 volumio sudo[3241]: pam_unix(sudo:session): session closed for user root Jun 20 12:01:18 volumio sudo[3243]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 12:01:18 volumio sudo[3243]: pam_unix(sudo:session): session closed for user root Jun 20 12:01:18 volumio volumio[2725]: info: CoreCommandRouter::volumioGetState Jun 20 12:01:18 volumio volumio[2725]: info: CorePlayQueue::getTrack 0 Jun 20 12:01:18 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 20 12:01:18 volumio volumio[2725]: info: Listing playlists Jun 20 12:01:18 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 20 12:01:18 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 20 12:01:18 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 20 12:01:18 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 12:01:19 volumio volumio[2725]: info: CoreCommandRouter::volumioGetQueue Jun 20 12:01:19 volumio volumio[2725]: info: CoreStateMachine::getQueue Jun 20 12:01:19 volumio volumio[2725]: info: CorePlayQueue::getQueue Jun 20 12:01:21 volumio volumio[2725]: info: CoreCommandRouter::volumioPlay Jun 20 12:01:21 volumio volumio[2725]: UNSET VOLATILE Jun 20 12:01:21 volumio volumio[2725]: info: CoreStateMachine::play index 8 Jun 20 12:01:21 volumio volumio[2725]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 12:01:21 volumio volumio[2725]: info: CoreStateMachine::stop Jun 20 12:01:21 volumio volumio[2725]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 12:01:21 volumio volumio[2725]: UNSET VOLATILE Jun 20 12:01:21 volumio volumio[2725]: info: CoreStateMachine::play index undefined Jun 20 12:01:21 volumio volumio[2725]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 20 12:01:21 volumio volumio[2725]: info: CorePlayQueue::getTrack 8 Jun 20 12:01:21 volumio volumio[2725]: info: CoreStateMachine::startPlaybackTimer Jun 20 12:01:21 volumio volumio[2725]: info: CorePlayQueue::getTrack 8 Jun 20 12:01:21 volumio volumio[2725]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷/1.音乐/优客李林 - 输了你赢了世界又如何.mp3 Jun 20 12:01:21 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand stop Jun 20 12:01:21 volumio volumio[2725]: info: sendMpdCommand stop took 4 milliseconds Jun 20 12:01:21 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand clear Jun 20 12:01:22 volumio volumio[2725]: info: Jun 20 12:01:22 volumio volumio[2725]: ---------------------------- MPD announces system playlist update Jun 20 12:01:22 volumio volumio[2725]: info: Ignoring MPD Status Update Jun 20 12:01:22 volumio volumio[2725]: info: sendMpdCommand clear took 1 milliseconds Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷/1.音乐/优客李林 - 输了你赢了世界又如何.mp3" Jun 20 12:01:22 volumio volumio[2725]: error: updateQueue error: null Jun 20 12:01:22 volumio volumio[2725]: info: Jun 20 12:01:22 volumio volumio[2725]: ---------------------------- MPD announces system playlist update Jun 20 12:01:22 volumio volumio[2725]: info: Ignoring MPD Status Update Jun 20 12:01:22 volumio volumio[2725]: info: ------------------------------ 3ms Jun 20 12:01:22 volumio volumio[2725]: info: sendMpdCommand add "USB/新加卷/1.音乐/优客李林 - 输了你赢了世界又如何.mp3" took 2 milliseconds Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand play Jun 20 12:01:22 volumio volumio[2725]: info: ------------------------------ 2ms Jun 20 12:01:22 volumio volumio[2725]: info: sendMpdCommand play took 2 milliseconds Jun 20 12:01:22 volumio volumio[2725]: info: Jun 20 12:01:22 volumio volumio[2725]: ---------------------------- MPD announces state update: player Jun 20 12:01:22 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Jun 20 12:01:22 volumio volumio[2725]: info: ControllerMpd::getState Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand status Jun 20 12:01:22 volumio volumio[2725]: info: Jun 20 12:01:22 volumio volumio[2725]: ---------------------------- MPD announces state update: player Jun 20 12:01:22 volumio volumio[2725]: info: sendMpdCommand status took 3 milliseconds Jun 20 12:01:22 volumio volumio[2725]: info: ControllerMpd::getState Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand status Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::parseState Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 20 12:01:22 volumio volumio[2725]: info: sendMpdCommand status took 6 milliseconds Jun 20 12:01:22 volumio volumio[2725]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::parseState Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::parseTrackInfo Jun 20 12:01:22 volumio volumio[2725]: info: ControllerMpd::pushState Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::servicePushState Jun 20 12:01:22 volumio volumio[2725]: info: CorePlayQueue::getTrack 8 Jun 20 12:01:22 volumio volumio[2725]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":257,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"优客李林 - 输了你赢了世界又如何.mp3","artist":null,"album":null,"uri":"USB/新加卷/1.音乐/优客李林 - 输了你赢了世界又如何.mp3","trackType":"mp3"} Jun 20 12:01:22 volumio volumio[2725]: verbose: CURRENT POSITION 8 Jun 20 12:01:22 volumio volumio[2725]: info: CoreStateMachine::syncState stateService play Jun 20 12:01:22 volumio volumio[2725]: info: CoreStateMachine::syncState currentStatus stop Jun 20 12:01:22 volumio volumio[2725]: info: CoreStateMachine::pushState Jun 20 12:01:22 volumio volumio[2725]: info: CorePlayQueue::getTrack 8 Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::volumioPushState Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 12:01:22 volumio volumio[2725]: info: ------------------------------ 20ms Jun 20 12:01:22 volumio volumio[2725]: info: sendMpdCommand playlistinfo took 10 milliseconds Jun 20 12:01:22 volumio volumio[2725]: verbose: ControllerMpd::parseTrackInfo Jun 20 12:01:22 volumio volumio[2725]: info: ControllerMpd::pushState Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::servicePushState Jun 20 12:01:22 volumio volumio[2725]: info: CorePlayQueue::getTrack 8 Jun 20 12:01:22 volumio volumio[2725]: verbose: STATE SERVICE {"status":"play","position":0,"seek":185,"duration":257,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"优客李林 - 输了你赢了世界又如何.mp3","artist":null,"album":null,"uri":"USB/新加卷/1.音乐/优客李林 - 输了你赢了世界又如何.mp3","trackType":"mp3"} Jun 20 12:01:22 volumio volumio[2725]: verbose: CURRENT POSITION 8 Jun 20 12:01:22 volumio volumio[2725]: info: CoreStateMachine::syncState stateService play Jun 20 12:01:22 volumio volumio[2725]: info: CoreStateMachine::syncState currentStatus play Jun 20 12:01:22 volumio volumio[2725]: info: Received an update from plugin. extracting info from payload Jun 20 12:01:22 volumio volumio[2725]: info: CoreStateMachine::pushState Jun 20 12:01:22 volumio volumio[2725]: info: CorePlayQueue::getTrack 8 Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::volumioPushState Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 12:01:22 volumio volumio[2725]: info: CoreStateMachine::pushState Jun 20 12:01:22 volumio volumio[2725]: info: CorePlayQueue::getTrack 8 Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::volumioPushState Jun 20 12:01:22 volumio volumio[2725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 12:01:22 volumio volumio[2725]: info: ------------------------------ 29ms Jun 20 12:01:31 volumio volumio[2725]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 12:01:31 volumio volumio[2725]: { Error: connect ETIMEDOUT 67.15.100.252:80 Jun 20 12:01:31 volumio volumio[2725]: at Object._errnoException (util.js:1022:11) Jun 20 12:01:31 volumio volumio[2725]: at _exceptionWithHostPort (util.js:1044:20) Jun 20 12:01:31 volumio volumio[2725]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jun 20 12:01:31 volumio volumio[2725]: code: 'ETIMEDOUT', Jun 20 12:01:31 volumio volumio[2725]: errno: 'ETIMEDOUT', Jun 20 12:01:31 volumio volumio[2725]: syscall: 'connect', Jun 20 12:01:31 volumio volumio[2725]: address: '67.15.100.252', Jun 20 12:01:31 volumio volumio[2725]: port: 80 } Jun 20 12:01:31 volumio volumio[2725]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 12:01:31 volumio sudo[3299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-20 12:00 Jun 20 12:01:31 volumio sudo[3299]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"