-- Logs begin at Thu 2019-02-14 23:11:58 NZDT, end at Wed 2026-01-28 19:38:34 NZDT. --
Jan 28 19:37:01 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPlay
Jan 28 19:37:01 rivoplus volumio[3113]: info: CoreStateMachine::play index undefined
Jan 28 19:37:01 rivoplus volumio[3113]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 28 19:37:01 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:01 rivoplus volumio[3113]: info: CoreStateMachine::startPlaybackTimer
Jan 28 19:37:01 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:01 rivoplus volumio[3113]: info: ControllerMpd::resume
Jan 28 19:37:01 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand play
Jan 28 19:37:01 rivoplus volumio[3113]: info:
Jan 28 19:37:01 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player
Jan 28 19:37:01 rivoplus volumio[3113]: info: sendMpdCommand play took 32 milliseconds
Jan 28 19:37:01 rivoplus volumio[3113]: info: ControllerMpd::getState
Jan 28 19:37:01 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 19:37:01 rivoplus volumio[3113]: info:
Jan 28 19:37:01 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player
Jan 28 19:37:01 rivoplus volumio[3113]: info: ControllerMpd::getState
Jan 28 19:37:01 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 19:37:01 rivoplus volumio[3113]: info:
Jan 28 19:37:01 rivoplus volumio[3113]: ---------------------------- MPD announces state update: player
Jan 28 19:37:01 rivoplus volumio[3113]: info: ControllerMpd::getState
Jan 28 19:37:01 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand status
Jan 28 19:37:02 rivoplus volumio[3113]: info: sendMpdCommand status took 6 milliseconds
Jan 28 19:37:02 rivoplus volumio[3113]: info: sendMpdCommand status took 10 milliseconds
Jan 28 19:37:02 rivoplus volumio[3113]: info: sendMpdCommand status took 9 milliseconds
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::parseState
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::parseState
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::parseState
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 28 19:37:02 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 28 19:37:02 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 28 19:37:02 rivoplus volumio[3113]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: ControllerMpd::parseTrackInfo
Jan 28 19:37:02 rivoplus volumio[3113]: info: ControllerMpd::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"play","position":0,"seek":120366,"duration":343,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3168 Kbps","isStreaming":false,"title":"Both Sides Now","artist":"Joni Mitchell","album":"Both Sides Now (96x24)","uri":"NAS/The_Vault/Joni Mitchell/Both Sides Now (hirez)/12-Both Sides Now.flac","trackType":"flac"}
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: CURRENT POSITION 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService play
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus pause
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: ControllerMpd::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"play","position":0,"seek":120366,"duration":343,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3168 Kbps","isStreaming":false,"title":"Both Sides Now","artist":"Joni Mitchell","album":"Both Sides Now (96x24)","uri":"NAS/The_Vault/Joni Mitchell/Both Sides Now (hirez)/12-Both Sides Now.flac","trackType":"flac"}
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: CURRENT POSITION 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService play
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus play
Jan 28 19:37:02 rivoplus volumio[3113]: info: Received an update from plugin. extracting info from payload
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: ControllerMpd::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::servicePushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: STATE SERVICE {"status":"play","position":0,"seek":120366,"duration":343,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3168 Kbps","isStreaming":false,"title":"Both Sides Now","artist":"Joni Mitchell","album":"Both Sides Now (96x24)","uri":"NAS/The_Vault/Joni Mitchell/Both Sides Now (hirez)/12-Both Sides Now.flac","trackType":"flac"}
Jan 28 19:37:02 rivoplus volumio[3113]: verbose: CURRENT POSITION 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::syncState stateService play
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::syncState currentStatus play
Jan 28 19:37:02 rivoplus volumio[3113]: info: Received an update from plugin. extracting info from payload
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreStateMachine::pushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: CorePlayQueue::getTrack 2
Jan 28 19:37:02 rivoplus volumio[3113]: info: CoreCommandRouter::volumioPushState
Jan 28 19:37:02 rivoplus volumio[3113]: info: ------------------------------ 105ms
Jan 28 19:37:02 rivoplus volumio[3113]: info: ------------------------------ 103ms
Jan 28 19:37:02 rivoplus volumio[3113]: info: ------------------------------ 101ms
Jan 28 19:37:02 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change
Jan 28 19:37:02 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change
Jan 28 19:37:02 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change
Jan 28 19:37:02 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change
Jan 28 19:37:02 rivoplus volumio[3113]: info: Signalling Playback active due to playback status change
Jan 28 19:37:02 rivoplus volumio[3113]: info: MCU Signalled Playback Active
Jan 28 19:37:54 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 28 19:37:54 rivoplus volumio[3113]: info: CURURI: artists://
Jan 28 19:37:55 rivoplus volumio[3113]: info: Preload queue cleared
Jan 28 19:38:00 rivoplus volumio[3113]: Searching plugin music_service/mpd
Jan 28 19:38:00 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 28 19:38:01 rivoplus volumio[3113]: Searching plugin music_service/mpd
Jan 28 19:38:01 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 28 19:38:03 rivoplus volumio[3113]: Searching plugin music_service/mpd
Jan 28 19:38:03 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 28 19:38:04 rivoplus volumio[3113]: Searching plugin music_service/mpd
Jan 28 19:38:04 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 28 19:38:05 rivoplus volumio[3113]: Searching plugin music_service/mpd
Jan 28 19:38:05 rivoplus volumio[3113]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 28 19:38:17 rivoplus volumio[3113]: Upnp client error: Error: This socket has been ended by the other party
Jan 28 19:38:17 rivoplus volumio[3113]: Upnp client error: Error: This socket has been ended by the other party
Jan 28 19:38:21 rivoplus volumio[3113]: Upnp client error: Error: This socket has been ended by the other party
Jan 28 19:38:21 rivoplus volumio[3113]: Upnp client error: Error: This socket has been ended by the other party
Jan 28 19:38:21 rivoplus volumio[3113]: Upnp client error: Error: This socket has been ended by the other party
Jan 28 19:38:21 rivoplus volumio[3113]: Upnp client error: Error: This socket has been ended by the other party
Jan 28 19:38:21 rivoplus volumio[3113]: Upnp client error: Error: This socket has been ended by the other party
Jan 28 19:38:23 rivoplus volumio[3113]: Cannot compose Albumart path
Jan 28 19:38:25 rivoplus volumio[3113]: Cannot compose Albumart path
Jan 28 19:38:25 rivoplus volumio[3113]: Cannot compose Albumart path
Jan 28 19:38:25 rivoplus volumio[3113]: info: All search sources collected, pushing search results
Jan 28 19:38:26 rivoplus volumio[3113]: info: All search sources collected, pushing search results
Jan 28 19:38:26 rivoplus volumio[3113]: info: All search sources collected, pushing search results
Jan 28 19:38:26 rivoplus volumio[3113]: info: All search sources collected, pushing search results
Jan 28 19:38:26 rivoplus volumio[3113]: info: All search sources collected, pushing search results
Jan 28 19:38:33 rivoplus volumio[3113]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 19:38:33 rivoplus volumio[3113]: Error: connect ECONNREFUSED 158.69.209.125:443
Jan 28 19:38:33 rivoplus volumio[3113]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jan 28 19:38:33 rivoplus volumio[3113]: errno: -111,
Jan 28 19:38:33 rivoplus volumio[3113]: code: 'ECONNREFUSED',
Jan 28 19:38:33 rivoplus volumio[3113]: syscall: 'connect',
Jan 28 19:38:33 rivoplus volumio[3113]: address: '158.69.209.125',
Jan 28 19:38:33 rivoplus volumio[3113]: port: 443
Jan 28 19:38:33 rivoplus volumio[3113]: }
Jan 28 19:38:33 rivoplus volumio[3113]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 28 19:38:34 rivoplus sudo[11268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 19:37
Jan 28 19:38:34 rivoplus sudo[11268]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivoplus"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo Plus"
VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"