-- Logs begin at Sat 2025-11-22 22:03:10 UTC, end at Thu 2025-12-11 22:04:51 UTC. -- Dec 11 22:03:56 s2ultra volumio[1225]: info: CoreCommandRouter::volumioGetVisibleSources Dec 11 22:03:56 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 22:03:56 s2ultra volumio[1225]: info: CoreCommandRouter::volumioGetState Dec 11 22:03:56 s2ultra volumio[1225]: info: CoreCommandRouter::volumioGetQueue Dec 11 22:03:56 s2ultra volumio[1225]: info: CoreStateMachine::getQueue Dec 11 22:03:56 s2ultra volumio[1225]: info: CorePlayQueue::getQueue Dec 11 22:03:56 s2ultra volumio[1225]: info: Listing playlists Dec 11 22:03:56 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 11 22:03:56 s2ultra volumio[1225]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 11 22:03:57 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 11 22:03:57 s2ultra volumio[1225]: info: browseTIDALUri took 132 milliseconds Dec 11 22:03:58 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Dec 11 22:03:58 s2ultra volumio[1225]: info: browseTIDALUri took 261 milliseconds Dec 11 22:04:04 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 11 22:04:06 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Dec 11 22:04:06 s2ultra volumio[1225]: info: Getting webradio selection Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::ClearQueue Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::stop Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::serviceStop Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::serviceStop Dec 11 22:04:08 s2ultra volumio[1225]: STOPPING SHAIRPORT WITH STOP Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::clearPlayQueue Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::saveQueue Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushQueue Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::addQueueItems Dec 11 22:04:08 s2ultra sudo[24137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::addQueueItems Dec 11 22:04:08 s2ultra volumio[1225]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Dec 11 22:04:08 s2ultra sudo[24137]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::saveQueue Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushQueue Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::updateTrackBlock Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::getTrackBlock Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPlay Dec 11 22:04:08 s2ultra volumio[1225]: verbose: UNSET VOLATILE Dec 11 22:04:08 s2ultra volumio[1225]: STOPPING SHAIRPORT WITH UNSET VOLATILE Dec 11 22:04:08 s2ultra systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 22:04:08 s2ultra systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::play index 0 Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::stop Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:04:08 s2ultra volumio[1225]: verbose: UNSET VOLATILE Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::stPlaybackTimer Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::updateTrackBlock Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::getTrackBlock Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:08 s2ultra sudo[24137]: pam_unix(sudo:session): session closed for user root Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::serviceStop Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::serviceStop Dec 11 22:04:08 s2ultra volumio[1225]: info: [1765490648468] ControllerWebradio::stop Dec 11 22:04:08 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 22:04:08 s2ultra volumio[1225]: info: Updating push state because input changed Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 22:04:08 s2ultra volumio[1225]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Dec 11 22:04:08 s2ultra volumio[1225]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Dec 11 22:04:08 s2ultra volumio[1225]: info: sendMpdCommand stop took 38 milliseconds Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::play index undefined Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::startPlaybackTimer Dec 11 22:04:08 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:08 s2ultra volumio[1225]: info: [1765490648511] ControllerWebradio::clearAddPlayTrack Dec 11 22:04:08 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 22:04:08 s2ultra sudo[24144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Dec 11 22:04:08 s2ultra volumio[1225]: info: sendMpdCommand stop took 4 milliseconds Dec 11 22:04:08 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 22:04:08 s2ultra volumio[1225]: info: Shairport-Sync Stopped Dec 11 22:04:08 s2ultra volumio[1225]: info: Dec 11 22:04:08 s2ultra volumio[1225]: ---------------------------- MPD announces system playlist update Dec 11 22:04:08 s2ultra volumio[1225]: info: Ignoring MPD Status Update Dec 11 22:04:08 s2ultra volumio[1225]: info: sendMpdCommand clear took 10 milliseconds Dec 11 22:04:08 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" Dec 11 22:04:08 s2ultra volumio[1225]: error: updateQueue error: null Dec 11 22:04:08 s2ultra volumio[1225]: info: ------------------------------ 5ms Dec 11 22:04:08 s2ultra sudo[24144]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 22:04:08 s2ultra systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 22:04:08 s2ultra volumio[1225]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Dec 11 22:04:08 s2ultra volumio[1225]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Dec 11 22:04:08 s2ultra sudo[24144]: pam_unix(sudo:session): session closed for user root Dec 11 22:04:08 s2ultra volumio[1225]: info: Shairport-Sync Stopped Dec 11 22:04:08 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" Dec 11 22:04:08 s2ultra volumio[1225]: info: Dec 11 22:04:08 s2ultra volumio[1225]: ---------------------------- MPD announces system playlist update Dec 11 22:04:08 s2ultra volumio[1225]: info: Ignoring MPD Status Update Dec 11 22:04:08 s2ultra volumio[1225]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" took 3 milliseconds Dec 11 22:04:08 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 11 22:04:08 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand play Dec 11 22:04:08 s2ultra volumio[1225]: info: ------------------------------ 4ms Dec 11 22:04:08 s2ultra volumio[1225]: info: sendMpdCommand play took 1 milliseconds Dec 11 22:04:09 s2ultra volumio[1225]: info: Dec 11 22:04:09 s2ultra volumio[1225]: ---------------------------- MPD announces state update: player Dec 11 22:04:09 s2ultra volumio[1225]: info: ControllerMpd::getState Dec 11 22:04:09 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand status Dec 11 22:04:09 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 11 22:04:09 s2ultra volumio[1225]: info: sendMpdCommand status took 4 milliseconds Dec 11 22:04:09 s2ultra volumio[1225]: verbose: ControllerMpd::parseState Dec 11 22:04:09 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 22:04:09 s2ultra volumio[1225]: info: sendMpdCommand clearerror took 5 milliseconds Dec 11 22:04:09 s2ultra volumio[1225]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 11 22:04:09 s2ultra volumio[1225]: verbose: ControllerMpd::parseTrackInfo Dec 11 22:04:09 s2ultra volumio[1225]: info: ControllerMpd::pushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::servicePushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:09 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:09 s2ultra volumio[1225]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_three","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three","trackType":""} Dec 11 22:04:09 s2ultra volumio[1225]: verbose: CURRENT POSITION 0 Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreStateMachine::syncState stateService stop Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreStateMachine::syncState currentStatus stop Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:09 s2ultra volumio[1225]: info: No code Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:09 s2ultra volumio[1225]: info: ------------------------------ 46ms Dec 11 22:04:09 s2ultra volumio[1225]: info: Updating push state because input changed Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::volumiosetSourceActivempd Dec 11 22:04:09 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 11 22:04:16 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPlay Dec 11 22:04:16 s2ultra volumio[1225]: verbose: UNSET VOLATILE Dec 11 22:04:16 s2ultra volumio[1225]: info: CoreStateMachine::play index undefined Dec 11 22:04:16 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:04:16 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:16 s2ultra volumio[1225]: info: CoreStateMachine::startPlaybackTimer Dec 11 22:04:16 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:16 s2ultra volumio[1225]: info: [1765490656711] ControllerWebradio::clearAddPlayTrack Dec 11 22:04:16 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 22:04:16 s2ultra volumio[1225]: info: sendMpdCommand stop took 5 milliseconds Dec 11 22:04:16 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 22:04:16 s2ultra volumio[1225]: info: Dec 11 22:04:16 s2ultra volumio[1225]: ---------------------------- MPD announces system playlist update Dec 11 22:04:16 s2ultra volumio[1225]: info: Ignoring MPD Status Update Dec 11 22:04:16 s2ultra volumio[1225]: info: sendMpdCommand clear took 3 milliseconds Dec 11 22:04:16 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" Dec 11 22:04:16 s2ultra volumio[1225]: error: updateQueue error: null Dec 11 22:04:16 s2ultra volumio[1225]: info: ------------------------------ 5ms Dec 11 22:04:16 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" Dec 11 22:04:16 s2ultra volumio[1225]: info: Dec 11 22:04:16 s2ultra volumio[1225]: ---------------------------- MPD announces system playlist update Dec 11 22:04:16 s2ultra volumio[1225]: info: Ignoring MPD Status Update Dec 11 22:04:16 s2ultra volumio[1225]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" took 3 milliseconds Dec 11 22:04:16 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 11 22:04:16 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand play Dec 11 22:04:16 s2ultra volumio[1225]: info: ------------------------------ 5ms Dec 11 22:04:16 s2ultra volumio[1225]: info: sendMpdCommand play took 3 milliseconds Dec 11 22:04:17 s2ultra volumio[1225]: info: Dec 11 22:04:17 s2ultra volumio[1225]: ---------------------------- MPD announces state update: player Dec 11 22:04:17 s2ultra volumio[1225]: info: ControllerMpd::getState Dec 11 22:04:17 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand status Dec 11 22:04:17 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 11 22:04:17 s2ultra volumio[1225]: info: sendMpdCommand status took 5 milliseconds Dec 11 22:04:17 s2ultra volumio[1225]: verbose: ControllerMpd::parseState Dec 11 22:04:17 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 22:04:17 s2ultra volumio[1225]: info: sendMpdCommand clearerror took 4 milliseconds Dec 11 22:04:17 s2ultra volumio[1225]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 11 22:04:17 s2ultra volumio[1225]: verbose: ControllerMpd::parseTrackInfo Dec 11 22:04:17 s2ultra volumio[1225]: info: ControllerMpd::pushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreCommandRouter::servicePushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:17 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:17 s2ultra volumio[1225]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_three","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three","trackType":""} Dec 11 22:04:17 s2ultra volumio[1225]: verbose: CURRENT POSITION 0 Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreStateMachine::syncState stateService stop Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreStateMachine::syncState currentStatus stop Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:17 s2ultra volumio[1225]: info: No code Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:17 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:17 s2ultra volumio[1225]: info: ------------------------------ 34ms Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPlay Dec 11 22:04:19 s2ultra volumio[1225]: verbose: UNSET VOLATILE Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::play index undefined Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 11 22:04:19 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::startPlaybackTimer Dec 11 22:04:19 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:19 s2ultra volumio[1225]: info: [1765490659524] ControllerWebradio::clearAddPlayTrack Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand stop Dec 11 22:04:19 s2ultra volumio[1225]: info: sendMpdCommand stop took 6 milliseconds Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand clear Dec 11 22:04:19 s2ultra volumio[1225]: info: Dec 11 22:04:19 s2ultra volumio[1225]: ---------------------------- MPD announces system playlist update Dec 11 22:04:19 s2ultra volumio[1225]: info: Ignoring MPD Status Update Dec 11 22:04:19 s2ultra volumio[1225]: info: sendMpdCommand clear took 3 milliseconds Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" Dec 11 22:04:19 s2ultra volumio[1225]: error: updateQueue error: null Dec 11 22:04:19 s2ultra volumio[1225]: info: ------------------------------ 4ms Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" Dec 11 22:04:19 s2ultra volumio[1225]: info: Dec 11 22:04:19 s2ultra volumio[1225]: ---------------------------- MPD announces system playlist update Dec 11 22:04:19 s2ultra volumio[1225]: info: Ignoring MPD Status Update Dec 11 22:04:19 s2ultra volumio[1225]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three" took 3 milliseconds Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand play Dec 11 22:04:19 s2ultra volumio[1225]: info: ------------------------------ 5ms Dec 11 22:04:19 s2ultra volumio[1225]: info: sendMpdCommand play took 2 milliseconds Dec 11 22:04:19 s2ultra volumio[1225]: info: Dec 11 22:04:19 s2ultra volumio[1225]: ---------------------------- MPD announces state update: player Dec 11 22:04:19 s2ultra volumio[1225]: info: ControllerMpd::getState Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand status Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand clearerror Dec 11 22:04:19 s2ultra volumio[1225]: info: sendMpdCommand status took 5 milliseconds Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::parseState Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 11 22:04:19 s2ultra volumio[1225]: info: sendMpdCommand clearerror took 3 milliseconds Dec 11 22:04:19 s2ultra volumio[1225]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 11 22:04:19 s2ultra volumio[1225]: verbose: ControllerMpd::parseTrackInfo Dec 11 22:04:19 s2ultra volumio[1225]: info: ControllerMpd::pushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::servicePushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:19 s2ultra volumio[1225]: info: CorePlayQueue::getTrack 0 Dec 11 22:04:19 s2ultra volumio[1225]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_radio_three","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_radio_three","trackType":""} Dec 11 22:04:19 s2ultra volumio[1225]: verbose: CURRENT POSITION 0 Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::syncState stateService stop Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::syncState currentStatus stop Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:19 s2ultra volumio[1225]: info: No code Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreStateMachine::pushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::volumioPushState Dec 11 22:04:19 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 11 22:04:19 s2ultra volumio[1225]: info: ------------------------------ 47ms Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:22 s2ultra volumio[1225]: No protocol specified Dec 11 22:04:22 s2ultra volumio[1225]: xcb_connection_has_error() returned true Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 11 22:04:22 s2ultra volumio[1225]: No protocol specified Dec 11 22:04:22 s2ultra volumio[1225]: xcb_connection_has_error() returned true Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 11 22:04:22 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:42 s2ultra volumio[1225]: info: Retrieving Cloud Streaming UI Dec 11 22:04:42 s2ultra volumio[1225]: info: Getting Tidal Cloud Configuration Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:42 s2ultra volumio[1225]: info: Getting Qobuz Cloud Configuration Dec 11 22:04:42 s2ultra volumio[1225]: info: Asking plugin for UI Config Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:42 s2ultra volumio[1225]: info: Getting Spotify Cloud Configuration Dec 11 22:04:42 s2ultra volumio[1225]: info: Asking plugin for UI Config Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:42 s2ultra volumio[1225]: error: Could not retrieve plugin music_service spotify Dec 11 22:04:42 s2ultra volumio[1225]: info: Saving Spotify Acccount Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:42 s2ultra volumio[1225]: info: Got it Dec 11 22:04:42 s2ultra volumio[1225]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 11 22:04:42 s2ultra volumio[1225]: info: Got Tidal Cloud Configuration Dec 11 22:04:42 s2ultra volumio[1225]: info: Got it Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 11 22:04:42 s2ultra volumio[1225]: info: CoreCommandRouter::volumioGetBrowseSources Dec 11 22:04:43 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 22:04:43 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 11 22:04:47 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 11 22:04:48 s2ultra volumio[1225]: info: Disabling MyMusic plugin upnp Dec 11 22:04:48 s2ultra sudo[24347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Dec 11 22:04:48 s2ultra sudo[24347]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 22:04:48 s2ultra systemd[1]: Stopping UPnP Renderer front-end to MPD... Dec 11 22:04:48 s2ultra volumio[1225]: Error in parsing BT Meta: TypeError: msg.body[0].indexOf is not a function Dec 11 22:04:50 s2ultra volumio[1225]: info: Enabling MyMusic plugin upnp Dec 11 22:04:50 s2ultra volumio[1225]: info: Enabling plugin upnp Dec 11 22:04:50 s2ultra volumio[1225]: info: Loading plugin "upnp"... Dec 11 22:04:50 s2ultra volumio[1225]: info: [1765490690379] Starting Upmpd Daemon Dec 11 22:04:50 s2ultra volumio[1225]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 11 22:04:50 s2ultra volumio[1225]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 22:04:50 s2ultra volumio[1225]: { Error: listen EADDRINUSE :::6599 Dec 11 22:04:50 s2ultra volumio[1225]: at Object._errnoException (util.js:1022:11) Dec 11 22:04:50 s2ultra volumio[1225]: at _exceptionWithHostPort (util.js:1044:20) Dec 11 22:04:50 s2ultra volumio[1225]: at Server.setupListenHandle [as _listen2] (net.js:1367:14) Dec 11 22:04:50 s2ultra volumio[1225]: at listenInCluster (net.js:1408:12) Dec 11 22:04:50 s2ultra volumio[1225]: at Server.listen (net.js:1492:7) Dec 11 22:04:50 s2ultra volumio[1225]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Dec 11 22:04:50 s2ultra volumio[1225]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:171:38) Dec 11 22:04:50 s2ultra volumio[1225]: at Promise._successFn (/volumio/app/pluginmanager.js:1548:19) Dec 11 22:04:50 s2ultra volumio[1225]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Dec 11 22:04:50 s2ultra volumio[1225]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Dec 11 22:04:50 s2ultra volumio[1225]: at process._tickCallback (internal/process/next_tick.js:180:9) Dec 11 22:04:50 s2ultra volumio[1225]: code: 'EADDRINUSE', Dec 11 22:04:50 s2ultra volumio[1225]: errno: 'EADDRINUSE', Dec 11 22:04:50 s2ultra volumio[1225]: syscall: 'listen', Dec 11 22:04:50 s2ultra volumio[1225]: address: '::', Dec 11 22:04:50 s2ultra volumio[1225]: port: 6599 } Dec 11 22:04:50 s2ultra volumio[1225]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 22:04:51 s2ultra sudo[24371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-11 22:03 Dec 11 22:04:51 s2ultra sudo[24371]: 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="projectsbus2" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Jul 13 17:22:02 CEST 2022" VOLUMIO_VERSION="1.079" VOLUMIO_HARDWARE="pi" VOLUMIO_VENDOR="Pro-Ject Audio Systems" VOLUMIO_MODEL="Stream Box S2 ultra" VOLUMIO_VENDOR_MODEL="Pro-Ject Stream Box S2 ultra" VOLUMIO_HASH="a5127ace113e6b9fcf2a1eaed5431093"