-- Logs begin at Tue 2025-04-29 13:34:11 CST, end at Tue 2025-04-29 13:48:36 CST. -- Apr 29 13:47:21 bath volumio[1006]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Apr 29 13:47:21 bath sudo[6033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 13:47:21 bath sudo[6033]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:21 bath sudo[6033]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:21 bath volumio[1006]: info: MPD Permissions set Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:21 bath sudo[6036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:21 bath sudo[6036]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:21 bath systemd[1]: Stopping Music Player Daemon... Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 13:47:21 bath systemd[1]: mpd.service: Succeeded. Apr 29 13:47:21 bath systemd[1]: Stopped Music Player Daemon. Apr 29 13:47:21 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:21 bath systemd[1]: Starting Music Player Daemon... Apr 29 13:47:21 bath sudo[6043]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 29 13:47:21 bath sudo[6043]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:21 bath sudo[6043]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:23 bath mpd[6048]: Apr 29 13:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 13:47:23 bath systemd[1]: Started Music Player Daemon. Apr 29 13:47:23 bath sudo[6036]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:23 bath volumio[1006]: error: updateQueue error: null Apr 29 13:47:31 bath volumio[1006]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Apr 29 13:47:31 bath sudo[6068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 13:47:31 bath sudo[6068]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:31 bath sudo[6068]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:31 bath volumio[1006]: info: MPD Permissions set Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:31 bath sudo[6071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 13:47:31 bath sudo[6071]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:31 bath systemd[1]: Stopping Music Player Daemon... Apr 29 13:47:31 bath systemd[1]: mpd.service: Succeeded. Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 13:47:31 bath systemd[1]: Stopped Music Player Daemon. Apr 29 13:47:31 bath systemd[1]: Starting Music Player Daemon... Apr 29 13:47:31 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:32 bath sudo[6077]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 29 13:47:32 bath sudo[6077]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:32 bath sudo[6077]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:33 bath mpd[6082]: Apr 29 13:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 13:47:33 bath systemd[1]: Started Music Player Daemon. Apr 29 13:47:33 bath sudo[6071]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:33 bath volumio[1006]: error: updateQueue error: null Apr 29 13:47:35 bath volumio[1006]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Apr 29 13:47:35 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Apr 29 13:47:35 bath sudo[6149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 13:47:35 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:35 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:35 bath sudo[6149]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:35 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:35 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:35 bath sudo[6149]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:35 bath sudo[6151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 13:47:35 bath sudo[6151]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:36 bath systemd[1]: Stopping Music Player Daemon... Apr 29 13:47:36 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 13:47:36 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 13:47:36 bath systemd[1]: mpd.service: Succeeded. Apr 29 13:47:36 bath systemd[1]: Stopped Music Player Daemon. Apr 29 13:47:36 bath systemd[1]: Starting Music Player Daemon... Apr 29 13:47:36 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 13:47:36 bath volumio[1006]: info: MPD Permissions set Apr 29 13:47:36 bath sudo[6158]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 29 13:47:36 bath sudo[6158]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 13:47:36 bath sudo[6158]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:37 bath mpd[6162]: Apr 29 13:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 13:47:37 bath systemd[1]: Started Music Player Daemon. Apr 29 13:47:37 bath sudo[6151]: pam_unix(sudo:session): session closed for user root Apr 29 13:47:37 bath volumio[1006]: error: updateQueue error: null Apr 29 13:47:45 bath nmbd[3101]: [2025/04/29 13:47:45.243855, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 29 13:47:45 bath nmbd[3101]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.50.84 for name WORKGROUP<1d>. Apr 29 13:47:45 bath nmbd[3101]: This response was from IP 192.168.50.162, reporting an IP address of 192.168.50.162. Apr 29 13:47:54 bath volumio[1006]: info: CoreCommandRouter::volumioPause Apr 29 13:47:54 bath volumio[1006]: info: CoreStateMachine::pause Apr 29 13:47:54 bath volumio[1006]: info: CoreStateMachine::stPlaybackTimer Apr 29 13:47:54 bath volumio[1006]: info: CoreStateMachine::servicePause Apr 29 13:47:54 bath volumio[1006]: info: CorePlayQueue::getTrack 0 Apr 29 13:47:54 bath volumio[1006]: info: Error: no service or no trackblock to pause Apr 29 13:47:54 bath volumio[1006]: info: CoreCommandRouter::volumioPause Apr 29 13:47:54 bath volumio[1006]: info: CoreStateMachine::pause Apr 29 13:47:57 bath volumio[1006]: info: CoreCommandRouter::volumioGetState Apr 29 13:47:57 bath volumio[1006]: info: CoreCommandRouter::volumioGetState Apr 29 13:47:59 bath volumio[1006]: info: CoreCommandRouter::volumioSeek Apr 29 13:47:59 bath volumio[1006]: info: CoreStateMachine::seek Apr 29 13:47:59 bath volumio[1006]: info: CorePlayQueue::getTrack 0 Apr 29 13:47:59 bath volumio[1006]: info: CoreCommandRouter::volumioSeek Apr 29 13:47:59 bath volumio[1006]: info: CoreStateMachine::seek Apr 29 13:47:59 bath volumio[1006]: info: CorePlayQueue::getTrack 0 Apr 29 13:48:00 bath volumio[1006]: info: CoreCommandRouter::volumioRandom Apr 29 13:48:00 bath volumio[1006]: info: CoreCommandRouter::writePlayerControls Apr 29 13:48:00 bath volumio[1006]: info: CoreStateMachine::setRepeat true single false Apr 29 13:48:00 bath volumio[1006]: info: CoreStateMachine::pushState Apr 29 13:48:00 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 13:48:00 bath volumio[1006]: info: CoreCommandRouter::volumioPushState Apr 29 13:48:00 bath volumio[1006]: info: CoreCommandRouter::volumioGetQueue Apr 29 13:48:00 bath volumio[1006]: info: CoreStateMachine::getQueue Apr 29 13:48:00 bath volumio[1006]: info: CorePlayQueue::getQueue Apr 29 13:48:12 bath volumio[1006]: info: CoreCommandRouter::volumioSeek Apr 29 13:48:12 bath volumio[1006]: info: CoreStateMachine::seek Apr 29 13:48:12 bath volumio[1006]: info: CorePlayQueue::getTrack 0 Apr 29 13:48:16 bath volumio[1006]: info: CoreCommandRouter::volumioPause Apr 29 13:48:16 bath volumio[1006]: info: CoreStateMachine::pause Apr 29 13:48:16 bath volumio[1006]: info: CoreCommandRouter::volumioPause Apr 29 13:48:16 bath volumio[1006]: info: CoreStateMachine::pause Apr 29 13:48:20 bath volumio[1006]: info: VolumeController::SetAlsaVolume57 Apr 29 13:48:20 bath volumio[1006]: info: CoreStateMachine::pushState Apr 29 13:48:20 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 13:48:20 bath volumio[1006]: info: CoreCommandRouter::volumioPushState Apr 29 13:48:21 bath volumio[1006]: info: CoreCommandRouter::volumioGetQueue Apr 29 13:48:21 bath volumio[1006]: info: CoreStateMachine::getQueue Apr 29 13:48:21 bath volumio[1006]: info: CorePlayQueue::getQueue Apr 29 13:48:34 bath volumio[1006]: info: Clearing queue after UPNP request Apr 29 13:48:34 bath volumio[1006]: info: CoreStateMachine::ClearQueue Apr 29 13:48:34 bath volumio[1006]: info: CoreStateMachine::stop Apr 29 13:48:34 bath volumio[1006]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 29 13:48:34 bath volumio[1006]: info: CoreStateMachine::updateTrackBlock Apr 29 13:48:34 bath volumio[1006]: info: CorePlayQueue::getTrackBlock Apr 29 13:48:34 bath volumio[1006]: info: CoreStateMachine::stPlaybackTimer Apr 29 13:48:34 bath volumio[1006]: info: CoreStateMachine::pushState Apr 29 13:48:34 bath volumio[1006]: info: CorePlayQueue::getTrack 0 Apr 29 13:48:34 bath volumio[1006]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 13:48:34 bath volumio[1006]: info: CoreCommandRouter::volumioPushState Apr 29 13:48:35 bath volumio[1006]: info: CoreStateMachine::serviceStop Apr 29 13:48:35 bath volumio[1006]: info: CorePlayQueue::getTrack 0 Apr 29 13:48:35 bath volumio[1006]: info: ControllerMpd::stop Apr 29 13:48:35 bath volumio[1006]: verbose: ControllerMpd::sendMpdCommand stop Apr 29 13:48:35 bath volumio[1006]: info: CorePlayQueue::clearPlayQueue Apr 29 13:48:35 bath volumio[1006]: info: CorePlayQueue::saveQueue Apr 29 13:48:35 bath volumio[1006]: info: CoreCommandRouter::volumioPushState Apr 29 13:48:35 bath volumio[1006]: info: CoreCommandRouter::volumioPushQueue Apr 29 13:48:35 bath volumio[1006]: error: Upnp client error: Error: This socket has been ended by the other party Apr 29 13:48:35 bath volumio[1006]: info: sendMpdCommand stop took 30 milliseconds Apr 29 13:48:35 bath volumio[1006]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 13:48:35 bath volumio[1006]: Error: connect ETIMEDOUT 128.121.243.235:443 Apr 29 13:48:35 bath volumio[1006]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Apr 29 13:48:35 bath volumio[1006]: errno: -110, Apr 29 13:48:35 bath volumio[1006]: code: 'ETIMEDOUT', Apr 29 13:48:35 bath volumio[1006]: syscall: 'connect', Apr 29 13:48:35 bath volumio[1006]: address: '128.121.243.235', Apr 29 13:48:35 bath volumio[1006]: port: 443 Apr 29 13:48:35 bath volumio[1006]: } Apr 29 13:48:35 bath volumio[1006]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 13:48:36 bath sudo[6336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 13:47 Apr 29 13:48:36 bath sudo[6336]: 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"