-- Logs begin at Wed 2025-03-19 13:37:23 CST, end at Wed 2025-03-19 13:42:34 CST. -- Mar 19 13:41:19 volumio volumio[895]: info: CALLMETHOD: audio_interface alsa_controller saveResamplingOpts [object Object] Mar 19 13:41:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveResamplingOpts Mar 19 13:41:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Mar 19 13:41:19 volumio sudo[2333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 19 13:41:19 volumio sudo[2333]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 19 13:41:19 volumio sudo[2333]: pam_unix(sudo:session): session closed for user root Mar 19 13:41:19 volumio sudo[2336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 19 13:41:19 volumio sudo[2336]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 19 13:41:19 volumio volumio[895]: info: MPD Permissions set Mar 19 13:41:19 volumio systemd[1]: Stopping Music Player Daemon... Mar 19 13:41:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 19 13:41:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 19 13:41:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 19 13:41:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 19 13:41:19 volumio systemd[1]: mpd.service: Succeeded. Mar 19 13:41:19 volumio systemd[1]: Stopped Music Player Daemon. Mar 19 13:41:19 volumio systemd[1]: Starting Music Player Daemon... Mar 19 13:41:19 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 19 13:41:19 volumio sudo[2342]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 19 13:41:19 volumio sudo[2342]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 19 13:41:19 volumio sudo[2342]: pam_unix(sudo:session): session closed for user root Mar 19 13:41:20 volumio mpd[2347]: Mar 19 13:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 19 13:41:20 volumio systemd[1]: Started Music Player Daemon. Mar 19 13:41:20 volumio sudo[2336]: pam_unix(sudo:session): session closed for user root Mar 19 13:41:20 volumio volumio[895]: error: updateQueue error: null Mar 19 13:41:30 volumio volumio[895]: info: CoreCommandRouter::volumioPlay Mar 19 13:41:30 volumio volumio[895]: info: CoreStateMachine::play index undefined Mar 19 13:41:30 volumio volumio[895]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:41:30 volumio volumio[895]: info: CorePlayQueue::getTrack 0 Mar 19 13:41:31 volumio volumio[895]: info: CoreCommandRouter::volumioPlay Mar 19 13:41:31 volumio volumio[895]: info: CoreStateMachine::play index undefined Mar 19 13:41:31 volumio volumio[895]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:41:31 volumio volumio[895]: info: CorePlayQueue::getTrack 0 Mar 19 13:41:51 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 19 13:41:51 volumio volumio[895]: info: Preload queue cleared Mar 19 13:41:55 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 19 13:41:55 volumio volumio[895]: info: Preload queue cleared Mar 19 13:41:59 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Mar 19 13:41:59 volumio volumio[895]: info: Preload queue cleared Mar 19 13:42:06 volumio volumio[895]: info: Preload queue cleared Mar 19 13:42:06 volumio volumio[895]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::ClearQueue Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::stop Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:42:06 volumio volumio[895]: info: CorePlayQueue::clearPlayQueue Mar 19 13:42:06 volumio volumio[895]: info: CorePlayQueue::saveQueue Mar 19 13:42:06 volumio volumio[895]: info: CoreCommandRouter::volumioPushQueue Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::addQueueItems Mar 19 13:42:06 volumio volumio[895]: info: CorePlayQueue::addQueueItems Mar 19 13:42:06 volumio volumio[895]: info: Preload queue cleared Mar 19 13:42:06 volumio volumio[895]: info: Adding Item to queue: http://stream.srg-ssr.ch/m/rsc_de/aacp_96 Mar 19 13:42:06 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 19 13:42:06 volumio volumio[895]: info: CoreCommandRouter::volumioPushQueue Mar 19 13:42:06 volumio volumio[895]: info: CorePlayQueue::saveQueue Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::updateTrackBlock Mar 19 13:42:06 volumio volumio[895]: info: CorePlayQueue::getTrackBlock Mar 19 13:42:06 volumio volumio[895]: info: CoreCommandRouter::volumioPlay Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::play index 0 Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::stop Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::play index undefined Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 13:42:06 volumio volumio[895]: info: CorePlayQueue::getTrack 0 Mar 19 13:42:06 volumio volumio[895]: info: CoreStateMachine::startPlaybackTimer Mar 19 13:42:06 volumio volumio[895]: info: CorePlayQueue::getTrack 0 Mar 19 13:42:06 volumio volumio[895]: info: [1742362926534] ControllerWebradio::clearAddPlayTrack Mar 19 13:42:06 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 13:42:06 volumio volumio[895]: info: sendMpdCommand stop took 5 milliseconds Mar 19 13:42:06 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 13:42:06 volumio volumio[895]: info: Mar 19 13:42:06 volumio volumio[895]: ---------------------------- MPD announces system playlist update Mar 19 13:42:06 volumio volumio[895]: info: Ignoring MPD Status Update Mar 19 13:42:06 volumio volumio[895]: info: sendMpdCommand clear took 2 milliseconds Mar 19 13:42:06 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand load "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" Mar 19 13:42:06 volumio volumio[895]: error: updateQueue error: null Mar 19 13:42:06 volumio volumio[895]: info: ------------------------------ 4ms Mar 19 13:42:08 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand add "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" Mar 19 13:42:08 volumio volumio[895]: info: Mar 19 13:42:08 volumio volumio[895]: ---------------------------- MPD announces system playlist update Mar 19 13:42:08 volumio volumio[895]: info: Ignoring MPD Status Update Mar 19 13:42:08 volumio volumio[895]: info: sendMpdCommand add "http://stream.srg-ssr.ch/m/rsc_de/aacp_96" took 1 milliseconds Mar 19 13:42:08 volumio volumio[895]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 19 13:42:08 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand play Mar 19 13:42:08 volumio volumio[895]: info: ------------------------------ 3ms Mar 19 13:42:08 volumio volumio[895]: info: sendMpdCommand play took 2 milliseconds Mar 19 13:42:09 volumio volumio[895]: info: Mar 19 13:42:09 volumio volumio[895]: ---------------------------- MPD announces state update: player Mar 19 13:42:09 volumio volumio[895]: info: ControllerMpd::getState Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:42:09 volumio volumio[895]: info: Mar 19 13:42:09 volumio volumio[895]: ---------------------------- MPD announces state update: player Mar 19 13:42:09 volumio volumio[895]: info: sendMpdCommand status took 5 milliseconds Mar 19 13:42:09 volumio volumio[895]: info: ControllerMpd::getState Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::parseState Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:42:09 volumio volumio[895]: info: Mar 19 13:42:09 volumio volumio[895]: ---------------------------- MPD announces system playlist update Mar 19 13:42:09 volumio volumio[895]: info: Ignoring MPD Status Update Mar 19 13:42:09 volumio volumio[895]: info: Mar 19 13:42:09 volumio volumio[895]: ---------------------------- MPD announces state update: player Mar 19 13:42:09 volumio volumio[895]: info: ControllerMpd::getState Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand status Mar 19 13:42:09 volumio volumio[895]: info: sendMpdCommand status took 10 milliseconds Mar 19 13:42:09 volumio volumio[895]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 19 13:42:09 volumio volumio[895]: info: ------------------------------ 6ms Mar 19 13:42:09 volumio volumio[895]: info: sendMpdCommand status took 4 milliseconds Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::parseState Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::parseState Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 13:42:09 volumio volumio[895]: info: ControllerMpd::pushState Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::servicePushState Mar 19 13:42:09 volumio volumio[895]: info: CorePlayQueue::getTrack 0 Mar 19 13:42:09 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Samuel Arnold - Ouvert?re zur Oper \"Polly\"","artist":"/SwissClassic_Room1.aac","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Mar 19 13:42:09 volumio volumio[895]: verbose: CURRENT POSITION 0 Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::syncState stateService play Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus stop Mar 19 13:42:09 volumio volumio[895]: info: ------------------------------ 36ms Mar 19 13:42:09 volumio volumio[895]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 19 13:42:09 volumio volumio[895]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:42:09 volumio volumio[895]: verbose: ControllerMpd::parseTrackInfo Mar 19 13:42:09 volumio volumio[895]: info: ControllerMpd::pushState Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::servicePushState Mar 19 13:42:09 volumio volumio[895]: info: CorePlayQueue::getTrack 0 Mar 19 13:42:09 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"94 Kbps","isStreaming":false,"title":"Samuel Arnold - Ouvert?re zur Oper \"Polly\"","artist":"/SwissClassic_Room1.aac","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Mar 19 13:42:09 volumio volumio[895]: verbose: CURRENT POSITION 0 Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::syncState stateService play Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:42:09 volumio volumio[895]: info: Received an update from plugin. extracting info from payload Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::pushState Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::volumioPushState Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::pushState Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::volumioPushState Mar 19 13:42:09 volumio volumio[895]: info: ControllerMpd::pushState Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::servicePushState Mar 19 13:42:09 volumio volumio[895]: info: CorePlayQueue::getTrack 0 Mar 19 13:42:09 volumio volumio[895]: verbose: STATE SERVICE {"status":"play","position":0,"seek":983,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"94 Kbps","isStreaming":false,"title":"Samuel Arnold - Ouvert?re zur Oper \"Polly\"","artist":"/SwissClassic_Room1.aac","album":null,"uri":"http://stream.srg-ssr.ch/m/rsc_de/aacp_96","trackType":""} Mar 19 13:42:09 volumio volumio[895]: verbose: CURRENT POSITION 0 Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::syncState stateService play Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::syncState currentStatus play Mar 19 13:42:09 volumio volumio[895]: info: Received an update from plugin. extracting info from payload Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::pushState Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::volumioPushState Mar 19 13:42:09 volumio volumio[895]: info: CoreStateMachine::pushState Mar 19 13:42:09 volumio volumio[895]: info: CoreCommandRouter::volumioPushState Mar 19 13:42:09 volumio volumio[895]: info: ------------------------------ 71ms Mar 19 13:42:09 volumio volumio[895]: info: ------------------------------ 63ms Mar 19 13:42:29 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 19 13:42:29 volumio volumio[895]: info: CURURI: music-library Mar 19 13:42:29 volumio volumio[895]: info: Preload queue cleared Mar 19 13:42:30 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 19 13:42:30 volumio volumio[895]: info: CURURI: music-library/USB Mar 19 13:42:30 volumio volumio[895]: info: Preload queue cleared Mar 19 13:42:31 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 19 13:42:31 volumio volumio[895]: info: CURURI: music-library/USB/kk Mar 19 13:42:31 volumio volumio[895]: info: Preload queue cleared Mar 19 13:42:32 volumio volumio[895]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 19 13:42:32 volumio volumio[895]: info: CURURI: music-library/USB/kk/music Mar 19 13:42:32 volumio volumio[895]: info: Preload queue cleared Mar 19 13:42:34 volumio volumio[895]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 19 13:42:34 volumio volumio[895]: Error: connect ETIMEDOUT 31.13.87.9:443 Mar 19 13:42:34 volumio volumio[895]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 19 13:42:34 volumio volumio[895]: errno: -110, Mar 19 13:42:34 volumio volumio[895]: code: 'ETIMEDOUT', Mar 19 13:42:34 volumio volumio[895]: syscall: 'connect', Mar 19 13:42:34 volumio volumio[895]: address: '31.13.87.9', Mar 19 13:42:34 volumio volumio[895]: port: 443 Mar 19 13:42:34 volumio volumio[895]: } Mar 19 13:42:34 volumio volumio[895]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 19 13:42:34 volumio sudo[2577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-19 13:41 Mar 19 13:42:34 volumio sudo[2577]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"