-- 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"