-- Logs begin at Sun 2025-03-02 13:15:25 UTC, end at Sun 2025-03-02 13:21:33 UTC. -- Mar 02 13:20:02 volumio sshd[1636]: Accepted password for volumio from 192.168.2.3 port 1423 ssh2 Mar 02 13:20:02 volumio sshd[1636]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Mar 02 13:20:02 volumio systemd[1]: Starting user-1000.slice. Mar 02 13:20:02 volumio systemd[1]: Created slice user-1000.slice. Mar 02 13:20:02 volumio systemd[1]: Starting User Manager for UID 1000... Mar 02 13:20:02 volumio systemd[1]: Starting Session c1 of user volumio. Mar 02 13:20:02 volumio systemd-logind[635]: New session c1 of user volumio. Mar 02 13:20:02 volumio systemd[1]: Started Session c1 of user volumio. Mar 02 13:20:02 volumio systemd[1661]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Mar 02 13:20:02 volumio systemd[1661]: Starting Paths. Mar 02 13:20:02 volumio systemd[1661]: Reached target Paths. Mar 02 13:20:02 volumio systemd[1661]: Starting Timers. Mar 02 13:20:02 volumio systemd[1661]: Reached target Timers. Mar 02 13:20:02 volumio systemd[1661]: Starting Sockets. Mar 02 13:20:02 volumio systemd[1661]: Reached target Sockets. Mar 02 13:20:02 volumio systemd[1661]: Starting Basic System. Mar 02 13:20:02 volumio systemd[1661]: Reached target Basic System. Mar 02 13:20:02 volumio systemd[1661]: Starting Default. Mar 02 13:20:02 volumio systemd[1661]: Reached target Default. Mar 02 13:20:02 volumio systemd[1661]: Startup finished in 38ms. Mar 02 13:20:02 volumio systemd[1]: Started User Manager for UID 1000. Mar 02 13:20:02 volumio sshd[1636]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory Mar 02 13:20:02 volumio sshd[1636]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory Mar 02 13:20:45 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:45 volumio volumio[1009]: info: CURURI: playlists Mar 02 13:20:45 volumio volumio[1009]: info: Listing playlists Mar 02 13:20:45 volumio volumio[1009]: info: CoreCommandRouter::volumioGetQueue Mar 02 13:20:45 volumio volumio[1009]: info: CoreStateMachine::getQueue Mar 02 13:20:45 volumio volumio[1009]: info: CorePlayQueue::getQueue Mar 02 13:20:47 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:47 volumio volumio[1009]: info: CURURI: music-library Mar 02 13:20:49 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:49 volumio volumio[1009]: info: CURURI: music-library/USB Mar 02 13:20:55 volumio sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 02 13:20:55 volumio sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 13:20:55 volumio sudo[1803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 02 13:20:55 volumio sudo[1801]: pam_unix(sudo:session): session closed for user root Mar 02 13:20:55 volumio sudo[1803]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 13:20:55 volumio sudo[1803]: pam_unix(sudo:session): session closed for user root Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::volumioGetVisibleSources Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::volumioGetState Mar 02 13:20:55 volumio volumio[1009]: info: CoreStateMachine::getState Mar 02 13:20:55 volumio volumio[1009]: info: CorePlayQueue::getTrack 0 Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::volumioGetQueue Mar 02 13:20:55 volumio volumio[1009]: info: CoreStateMachine::getQueue Mar 02 13:20:55 volumio volumio[1009]: info: CorePlayQueue::getQueue Mar 02 13:20:55 volumio volumio[1009]: info: Listing playlists Mar 02 13:20:55 volumio sudo[1821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 02 13:20:55 volumio sudo[1821]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 02 13:20:55 volumio sudo[1821]: pam_unix(sudo:session): session closed for user root Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 02 13:20:55 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 02 13:20:55 volumio sudo[1826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 02 13:20:55 volumio sudo[1826]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 13:20:55 volumio sudo[1826]: pam_unix(sudo:session): session closed for user root Mar 02 13:20:56 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:56 volumio volumio[1009]: info: CURURI: artists:// Mar 02 13:20:57 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:57 volumio volumio[1009]: info: CURURI: music-library Mar 02 13:20:57 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:57 volumio volumio[1009]: info: CURURI: music-library Mar 02 13:20:57 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:57 volumio volumio[1009]: info: CURURI: music-library/USB Mar 02 13:20:59 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:20:59 volumio volumio[1009]: info: CURURI: music-library/USB/203B-D56E Mar 02 13:21:00 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 02 13:21:00 volumio volumio[1009]: info: CURURI: music-library/USB/203B-D56E/2001-UPS不断电 Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::volumioAddQueueItems Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::addQueueItems Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::addQueueItems Mar 02 13:21:01 volumio volumio[1009]: info: Adding Item to queue: music-library/USB/203B-D56E/2001-UPS不断电/01 - Higer Power.flac Mar 02 13:21:01 volumio volumio[1009]: info: Exploding uri music-library/USB/203B-D56E/2001-UPS不断电/01 - Higer Power.flac in service mpd Mar 02 13:21:01 volumio volumio[1009]: info: ALBUMART /albumart?cacheid=38&web=%5B51ape.com%5D%E5%8A%A8%E5%8A%9B%E7%81%AB%E8%BD%A6/UPS%E4%B8%8D%E6%96%AD%E7%94%B5/extralarge&path=%2Fmnt%2FUSB%2F203B-D56E%2F2001-UPS%E4%B8%8D%E6%96%AD%E7%94%B5%2F01%20-%20Higer%20Power.flac&metadata=false Mar 02 13:21:01 volumio volumio[1009]: info: URI /mnt/USB/203B-D56E/2001-UPS不断电/01 - Higer Power.flac Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::saveQueue Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::volumioPushQueue Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::updateTrackBlock Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::getTrackBlock Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::volumioPlay Mar 02 13:21:01 volumio volumio[1009]: UNSET VOLATILE Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::play index 0 Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::stop Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 02 13:21:01 volumio volumio[1009]: UNSET VOLATILE Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::play index undefined Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::getTrack 0 Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::startPlaybackTimer Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::getTrack 0 Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::clearAddPlayTracks USB/203B-D56E/2001-UPS不断电/01 - Higer Power.flac Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand stop Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand clear Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: Mar 02 13:21:01 volumio volumio[1009]: ---------------------------- MPD announces system playlist update Mar 02 13:21:01 volumio volumio[1009]: info: Ignoring MPD Status Update Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand add "USB/203B-D56E/2001-UPS不断电/01 - Higer Power.flac" Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: Mar 02 13:21:01 volumio volumio[1009]: info: Mar 02 13:21:01 volumio volumio[1009]: ---------------------------- MPD announces system playlist update Mar 02 13:21:01 volumio volumio[1009]: info: Ignoring MPD Status Update Mar 02 13:21:01 volumio volumio[1009]: info: ------------------------------ 10ms Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand play Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: ------------------------------ 7ms Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: Mar 02 13:21:01 volumio volumio[1009]: ---------------------------- MPD announces state update: player Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::getState Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand status Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: Mar 02 13:21:01 volumio volumio[1009]: ---------------------------- MPD announces state update: player Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::getState Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand status Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand clearerror Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand clearerror Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::parseState Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand playlistinfo Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::parseState Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::sendMpdCommand playlistinfo Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: sending command... Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: parsing response... Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::parseTrackInfo Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::parseTrackInfo Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::pushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::servicePushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::syncState Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::getTrack 0 Mar 02 13:21:01 volumio volumio[1009]: info: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"0 Kbps","isStreaming":false,"title":"Higer Power","artist":"[51ape.com]动力火车","album":"UPS不断电","uri":"USB/203B-D56E/2001-UPS不断电/01 - Higer Power.flac","trackType":"flac"} Mar 02 13:21:01 volumio volumio[1009]: info: CURRENT POSITION 0 Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::syncState stateService pause Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::syncState currentStatus stop Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::pushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::getState Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::getTrack 0 Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::volumioPushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 13:21:01 volumio volumio[1009]: info: ControllerMpd::pushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::servicePushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::syncState Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::getTrack 0 Mar 02 13:21:01 volumio volumio[1009]: info: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"0 Kbps","isStreaming":false,"title":"Higer Power","artist":"[51ape.com]动力火车","album":"UPS不断电","uri":"USB/203B-D56E/2001-UPS不断电/01 - Higer Power.flac","trackType":"flac"} Mar 02 13:21:01 volumio volumio[1009]: info: CURRENT POSITION 0 Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::syncState stateService pause Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::syncState currentStatus stop Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::pushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreStateMachine::getState Mar 02 13:21:01 volumio volumio[1009]: info: CorePlayQueue::getTrack 0 Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::volumioPushState Mar 02 13:21:01 volumio volumio[1009]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 13:21:01 volumio sudo[1853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 02 13:21:01 volumio sudo[1853]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 13:21:01 volumio volumio[1009]: info: ------------------------------ 139ms Mar 02 13:21:01 volumio sudo[1856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 02 13:21:01 volumio volumio[1009]: info: ------------------------------ 137ms Mar 02 13:21:01 volumio sudo[1853]: pam_unix(sudo:session): session closed for user root Mar 02 13:21:01 volumio sudo[1856]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 13:21:01 volumio sudo[1856]: pam_unix(sudo:session): session closed for user root Mar 02 13:21:32 volumio volumio[1009]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 13:21:32 volumio volumio[1009]: { Error: connect ETIMEDOUT 128.242.240.117:80 Mar 02 13:21:32 volumio volumio[1009]: at Object._errnoException (util.js:1022:11) Mar 02 13:21:32 volumio volumio[1009]: at _exceptionWithHostPort (util.js:1044:20) Mar 02 13:21:32 volumio volumio[1009]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Mar 02 13:21:32 volumio volumio[1009]: code: 'ETIMEDOUT', Mar 02 13:21:32 volumio volumio[1009]: errno: 'ETIMEDOUT', Mar 02 13:21:32 volumio volumio[1009]: syscall: 'connect', Mar 02 13:21:32 volumio volumio[1009]: address: '128.242.240.117', Mar 02 13:21:32 volumio volumio[1009]: port: 80 } Mar 02 13:21:32 volumio volumio[1009]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 13:21:33 volumio sudo[1962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-02 13:20 Mar 02 13:21:33 volumio sudo[1962]: 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="ba22215fabbe766d668749499a1c25fcefd90f0a" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="043dcaee624f27d121213b83af11a9f2feac0945" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 18 01:32:43 CET 2020" VOLUMIO_VERSION="2.729" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5a0b29326faa8f5d0f5fe95d9e58c069"