-- Logs begin at Fri 2024-05-03 13:33:38 UTC, end at Fri 2024-05-03 13:59:06 UTC. -- May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 03 13:58:23 volumio volumio[2133]: info: Discovery: Getting this device information May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::volumioGetState May 03 13:58:23 volumio volumio[2133]: info: CorePlayQueue::getTrack 17 May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::volumioGetState May 03 13:58:23 volumio volumio[2133]: info: CorePlayQueue::getTrack 17 May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 03 13:58:23 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 03 13:58:25 volumio sudo[5368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 03 13:58:25 volumio sudo[5368]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 13:58:25 volumio sudo[5371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 03 13:58:25 volumio sudo[5368]: pam_unix(sudo:session): session closed for user root May 03 13:58:25 volumio sudo[5371]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 13:58:25 volumio sudo[5371]: pam_unix(sudo:session): session closed for user root May 03 13:58:25 volumio volumio[2133]: info: CoreCommandRouter::volumioGetState May 03 13:58:25 volumio volumio[2133]: info: CorePlayQueue::getTrack 17 May 03 13:58:25 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 03 13:58:25 volumio volumio[2133]: info: Listing playlists May 03 13:58:25 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 03 13:58:25 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 03 13:58:25 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 03 13:58:25 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::volumioNext May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::next May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::stop May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 13:58:28 volumio volumio[2133]: UNSET VOLATILE May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::stPlaybackTimer May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::updateTrackBlock May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrackBlock May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::pushState May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 17 May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::volumioPushState May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::serviceStop May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 17 May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::serviceStop May 03 13:58:28 volumio volumio[2133]: info: ControllerMpd::stop May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand stop May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand stop took 22 milliseconds May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::play index undefined May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 18 May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::startPlaybackTimer May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 18 May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::clearAddPlayTracks USB/新加卷_/1.音乐/刘德华 - 今天.mp3 May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand stop May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::updateTrackBlock May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrackBlock May 03 13:58:28 volumio volumio[2133]: info: May 03 13:58:28 volumio volumio[2133]: ---------------------------- MPD announces state update: player May 03 13:58:28 volumio volumio[2133]: info: ControllerMpd::getState May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand status May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand stop took 3 milliseconds May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand clear May 03 13:58:28 volumio volumio[2133]: info: May 03 13:58:28 volumio volumio[2133]: ---------------------------- MPD announces system playlist update May 03 13:58:28 volumio volumio[2133]: info: Ignoring MPD Status Update May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand status took 3 milliseconds May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand clear took 2 milliseconds May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::parseState May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand add "USB/新加卷_/1.音乐/刘德华 - 今天.mp3" May 03 13:58:28 volumio volumio[2133]: error: updateQueue error: null May 03 13:58:28 volumio volumio[2133]: info: May 03 13:58:28 volumio volumio[2133]: ---------------------------- MPD announces system playlist update May 03 13:58:28 volumio volumio[2133]: info: Ignoring MPD Status Update May 03 13:58:28 volumio volumio[2133]: info: ------------------------------ 3ms May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand playlistinfo took 2 milliseconds May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand add "USB/新加卷_/1.音乐/刘德华 - 今天.mp3" took 2 milliseconds May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::parseTrackInfo May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand play May 03 13:58:28 volumio volumio[2133]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 03 13:58:28 volumio volumio[2133]: info: ------------------------------ 6ms May 03 13:58:28 volumio volumio[2133]: info: ------------------------------ 2ms May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand play took 2 milliseconds May 03 13:58:28 volumio volumio[2133]: info: May 03 13:58:28 volumio volumio[2133]: ---------------------------- MPD announces state update: player May 03 13:58:28 volumio volumio[2133]: info: ControllerMpd::getState May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand status May 03 13:58:28 volumio volumio[2133]: info: May 03 13:58:28 volumio volumio[2133]: ---------------------------- MPD announces state update: player May 03 13:58:28 volumio volumio[2133]: info: ControllerMpd::getState May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand status May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand status took 1 milliseconds May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::parseState May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand status took 1 milliseconds May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand playlistinfo took 1 milliseconds May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::parseState May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::parseTrackInfo May 03 13:58:28 volumio volumio[2133]: info: ControllerMpd::pushState May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::servicePushState May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 18 May 03 13:58:28 volumio volumio[2133]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"½ñÌì","artist":"ÁõµÂ»ª","album":null,"uri":"USB/新加卷_/1.音乐/刘德华 - 今天.mp3","trackType":"mp3"} May 03 13:58:28 volumio volumio[2133]: verbose: CURRENT POSITION 18 May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::syncState stateService play May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::syncState currentStatus stop May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::pushState May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 18 May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::volumioPushState May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 13:58:28 volumio volumio[2133]: info: ------------------------------ 11ms May 03 13:58:28 volumio volumio[2133]: info: sendMpdCommand playlistinfo took 7 milliseconds May 03 13:58:28 volumio volumio[2133]: verbose: ControllerMpd::parseTrackInfo May 03 13:58:28 volumio volumio[2133]: info: ControllerMpd::pushState May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::servicePushState May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 18 May 03 13:58:28 volumio volumio[2133]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"½ñÌì","artist":"ÁõµÂ»ª","album":null,"uri":"USB/新加卷_/1.音乐/刘德华 - 今天.mp3","trackType":"mp3"} May 03 13:58:28 volumio volumio[2133]: verbose: CURRENT POSITION 18 May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::syncState stateService play May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::syncState currentStatus play May 03 13:58:28 volumio volumio[2133]: info: Received an update from plugin. extracting info from payload May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::pushState May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 18 May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::volumioPushState May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 13:58:28 volumio volumio[2133]: info: CoreStateMachine::pushState May 03 13:58:28 volumio volumio[2133]: info: CorePlayQueue::getTrack 18 May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::volumioPushState May 03 13:58:28 volumio volumio[2133]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 13:58:28 volumio volumio[2133]: info: ------------------------------ 46ms May 03 13:59:06 volumio volumio[2133]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 13:59:06 volumio volumio[2133]: { Error: connect ETIMEDOUT 192.133.77.189:80 May 03 13:59:06 volumio volumio[2133]: at Object._errnoException (util.js:1022:11) May 03 13:59:06 volumio volumio[2133]: at _exceptionWithHostPort (util.js:1044:20) May 03 13:59:06 volumio volumio[2133]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 03 13:59:06 volumio volumio[2133]: code: 'ETIMEDOUT', May 03 13:59:06 volumio volumio[2133]: errno: 'ETIMEDOUT', May 03 13:59:06 volumio volumio[2133]: syscall: 'connect', May 03 13:59:06 volumio volumio[2133]: address: '192.133.77.189', May 03 13:59:06 volumio volumio[2133]: port: 80 } May 03 13:59:06 volumio volumio[2133]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 13:59:06 volumio sudo[5480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 13:58 May 03 13:59:06 volumio sudo[5480]: 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"