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