-- Logs begin at Sat 2024-10-12 14:02:34 UTC, end at Fri 2025-01-17 11:02:29 UTC. -- Jan 17 11:01:00 volumio volumio[2771]: info: MPD Database updated - AlbumList cache refreshed Jan 17 11:01:00 volumio volumio[2771]: info: Jan 17 11:01:00 volumio volumio[2771]: ---------------------------- MPD announces state update: database Jan 17 11:01:00 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:01:00 volumio volumio[2771]: info: Jan 17 11:01:00 volumio volumio[2771]: ---------------------------- MPD announces state update: update Jan 17 11:01:00 volumio volumio[2771]: info: ControllerMpd::getState Jan 17 11:01:00 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:01:00 volumio volumio[2771]: info: ControllerMpd::getState Jan 17 11:01:00 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:01:05 volumio volumio[2771]: verbose: ControllerMpd::parseState Jan 17 11:01:05 volumio volumio[2771]: info: Command Router : Notfying DB Updatefalse Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::Close All Modals sent Jan 17 11:01:05 volumio volumio[2771]: verbose: ControllerMpd::parseState Jan 17 11:01:05 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:01:05 volumio volumio[2771]: verbose: ControllerMpd::parseState Jan 17 11:01:05 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:01:05 volumio volumio[2771]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:01:05 volumio volumio[2771]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:01:05 volumio volumio[2771]: info: ControllerMpd::pushState Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::servicePushState Jan 17 11:01:05 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:01:05 volumio volumio[2771]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87469,"duration":499,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????:????","artist":"(?)??? ????:??","album":null,"uri":"USB/0DCA11CA0DCA11CA/02.雨果全系列 400+CD/雨果唱片 50CD/CD15/梆笛协奏曲：第一乐章.wav","trackType":"wav"} Jan 17 11:01:05 volumio volumio[2771]: verbose: CURRENT POSITION 0 Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::syncState stateService play Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:01:05 volumio volumio[2771]: info: Received an update from plugin. extracting info from payload Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:01:05 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:01:05 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:01:05 volumio volumio[2771]: info: ControllerMpd::pushState Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::servicePushState Jan 17 11:01:05 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:01:05 volumio volumio[2771]: verbose: STATE SERVICE {"status":"play","position":0,"seek":87469,"duration":499,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"?????:????","artist":"(?)??? ????:??","album":null,"uri":"USB/0DCA11CA0DCA11CA/02.雨果全系列 400+CD/雨果唱片 50CD/CD15/梆笛协奏曲：第一乐章.wav","trackType":"wav"} Jan 17 11:01:05 volumio volumio[2771]: verbose: CURRENT POSITION 0 Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::syncState stateService play Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:01:05 volumio volumio[2771]: info: Received an update from plugin. extracting info from payload Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:01:05 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:01:05 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:01:05 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:01:05 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:01:05 volumio volumio[2771]: info: ------------------------------ 5422ms Jan 17 11:01:05 volumio volumio[2771]: info: ------------------------------ 5422ms Jan 17 11:01:11 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 17 11:01:11 volumio volumio[2771]: info: CURURI: playlists Jan 17 11:01:11 volumio volumio[2771]: info: Listing playlists Jan 17 11:01:47 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 17 11:01:47 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 11:01:47 volumio volumio[2771]: info: Discovery: Getting this device information Jan 17 11:01:47 volumio volumio[2771]: info: CoreCommandRouter::volumioGetState Jan 17 11:01:47 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:01:47 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Jan 17 11:01:47 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 17 11:01:47 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: system , getConf Jan 17 11:01:55 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 17 11:01:55 volumio volumio[2771]: info: CURURI: albums:// Jan 17 11:01:55 volumio volumio[2771]: listAlbums - loading Albums from cache Jan 17 11:02:16 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 17 11:02:16 volumio volumio[2771]: info: CURURI: albums://%E5%BC%A0%E5%9B%BD%E8%8D%A3/Forever Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::ClearQueue Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::stop Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:02:20 volumio volumio[2771]: UNSET VOLATILE Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::stPlaybackTimer Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::updateTrackBlock Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrackBlock Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::serviceStop Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::serviceStop Jan 17 11:02:20 volumio volumio[2771]: info: ControllerMpd::stop Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand stop Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::clearPlayQueue Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::saveQueue Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPushQueue Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::addQueueItems Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::addQueueItems Jan 17 11:02:20 volumio volumio[2771]: info: Adding Item to queue: albums://%E5%BC%A0%E5%9B%BD%E8%8D%A3/Forever Jan 17 11:02:20 volumio volumio[2771]: info: Exploding uri albums://%E5%BC%A0%E5%9B%BD%E8%8D%A3/Forever in service mpd Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::saveQueue Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPushQueue Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::updateTrackBlock Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrackBlock Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPlay Jan 17 11:02:20 volumio volumio[2771]: UNSET VOLATILE Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::play index 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::stop Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:02:20 volumio volumio[2771]: UNSET VOLATILE Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::play index undefined Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::startPlaybackTimer Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::clearAddPlayTracks USB/0DCA11CA0DCA11CA/无损音乐/Forever/1.Tonight and Forever.dsf Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand stop Jan 17 11:02:20 volumio volumio[2771]: info: Jan 17 11:02:20 volumio volumio[2771]: ---------------------------- MPD announces state update: player Jan 17 11:02:20 volumio volumio[2771]: info: ControllerMpd::getState Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand clear Jan 17 11:02:20 volumio volumio[2771]: info: Jan 17 11:02:20 volumio volumio[2771]: ---------------------------- MPD announces system playlist update Jan 17 11:02:20 volumio volumio[2771]: info: Ignoring MPD Status Update Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::parseState Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand add "USB/0DCA11CA0DCA11CA/无损音乐/Forever/1.Tonight and Forever.dsf" Jan 17 11:02:20 volumio volumio[2771]: error: updateQueue error: null Jan 17 11:02:20 volumio volumio[2771]: info: Jan 17 11:02:20 volumio volumio[2771]: ---------------------------- MPD announces system playlist update Jan 17 11:02:20 volumio volumio[2771]: info: Ignoring MPD Status Update Jan 17 11:02:20 volumio volumio[2771]: info: ------------------------------ 9ms Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand play Jan 17 11:02:20 volumio volumio[2771]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 17 11:02:20 volumio volumio[2771]: info: ------------------------------ 19ms Jan 17 11:02:20 volumio volumio[2771]: info: ------------------------------ 13ms Jan 17 11:02:20 volumio volumio[2771]: info: Jan 17 11:02:20 volumio volumio[2771]: ---------------------------- MPD announces state update: player Jan 17 11:02:20 volumio volumio[2771]: info: ControllerMpd::getState Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:02:20 volumio volumio[2771]: info: Jan 17 11:02:20 volumio volumio[2771]: ---------------------------- MPD announces state update: player Jan 17 11:02:20 volumio volumio[2771]: info: ControllerMpd::getState Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand status Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::parseState Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::parseState Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:02:20 volumio volumio[2771]: info: ControllerMpd::pushState Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::servicePushState Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"Tonight and Forever","artist":"张国荣","album":"Forever","uri":"USB/0DCA11CA0DCA11CA/无损音乐/Forever/1.Tonight and Forever.dsf","trackType":"dsf"} Jan 17 11:02:20 volumio volumio[2771]: verbose: CURRENT POSITION 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::syncState stateService play Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::syncState currentStatus stop Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:02:20 volumio volumio[2771]: info: ------------------------------ 244ms Jan 17 11:02:20 volumio volumio[2771]: verbose: ControllerMpd::parseTrackInfo Jan 17 11:02:20 volumio volumio[2771]: info: ControllerMpd::pushState Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::servicePushState Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2822 Kbps","isStreaming":false,"title":"Tonight and Forever","artist":"张国荣","album":"Forever","uri":"USB/0DCA11CA0DCA11CA/无损音乐/Forever/1.Tonight and Forever.dsf","trackType":"dsf"} Jan 17 11:02:20 volumio volumio[2771]: verbose: CURRENT POSITION 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::syncState stateService play Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::syncState currentStatus play Jan 17 11:02:20 volumio volumio[2771]: info: Received an update from plugin. extracting info from payload Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:02:20 volumio volumio[2771]: info: CoreStateMachine::pushState Jan 17 11:02:20 volumio volumio[2771]: info: CorePlayQueue::getTrack 0 Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::volumioPushState Jan 17 11:02:20 volumio volumio[2771]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 11:02:20 volumio volumio[2771]: info: ------------------------------ 44ms Jan 17 11:02:28 volumio volumio[2771]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 11:02:28 volumio volumio[2771]: { Error: connect ETIMEDOUT 128.242.245.43:80 Jan 17 11:02:28 volumio volumio[2771]: at Object._errnoException (util.js:1022:11) Jan 17 11:02:28 volumio volumio[2771]: at _exceptionWithHostPort (util.js:1044:20) Jan 17 11:02:28 volumio volumio[2771]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jan 17 11:02:28 volumio volumio[2771]: code: 'ETIMEDOUT', Jan 17 11:02:28 volumio volumio[2771]: errno: 'ETIMEDOUT', Jan 17 11:02:28 volumio volumio[2771]: syscall: 'connect', Jan 17 11:02:28 volumio volumio[2771]: address: '128.242.245.43', Jan 17 11:02:28 volumio volumio[2771]: port: 80 } Jan 17 11:02:28 volumio volumio[2771]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 11:02:29 volumio sudo[3913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 11:01 Jan 17 11:02:29 volumio sudo[3913]: 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="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"