-- Logs begin at Wed 2024-11-27 22:24:08 CST, end at Wed 2024-11-27 22:53:41 CST. -- Nov 27 22:52:02 volumioben volumio[4772]: info: CoreCommandRouter::volumioPlay Nov 27 22:52:02 volumioben volumio[4772]: info: CoreStateMachine::play index undefined Nov 27 22:52:02 volumioben volumio[4772]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 22:52:02 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:02 volumioben volumio[4772]: info: CoreStateMachine::startPlaybackTimer Nov 27 22:52:02 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:02 volumioben volumio[4772]: info: [1732719122074] ControllerUPNPBrowser::clearAddPlayTrack Nov 27 22:52:02 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 22:52:16 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:16 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:16 volumioben volumio[4772]: info: Prefetching next song Nov 27 22:52:16 volumioben volumio[4772]: info: Doing Prefetch in UPNP Nov 27 22:52:16 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.74:10243/WMPNSSv4/2768834716/0_MTRfOTc5ZDlmNmNfYTdmMzM1NzgtMjEzMA.mp3" Nov 27 22:52:20 volumioben volumio[4772]: info: CoreStateMachine::startPlaybackTimer Nov 27 22:52:20 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:21 volumioben volumio[4772]: info: CoreStateMachine::pushState Nov 27 22:52:21 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:21 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 22:52:21 volumioben volumio[4772]: info: CoreCommandRouter::volumioPushState Nov 27 22:52:25 volumioben volumio[4772]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 27 22:52:25 volumioben volumio[4772]: info: Retrying Login Due to Network Error Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 27 22:52:33 volumioben volumio[4772]: info: Getting Alsa Cards List without I2S DAC Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 27 22:52:33 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 27 22:52:34 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:34 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:34 volumioben volumio[4772]: info: Prefetching next song Nov 27 22:52:34 volumioben volumio[4772]: info: Doing Prefetch in UPNP Nov 27 22:52:34 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.74:10243/WMPNSSv4/2768834716/0_MTRfOTc5ZDlmNmNfYTdmMzM1NzgtMjEzMA.mp3" Nov 27 22:52:35 volumioben volumio[4772]: info: MyVolumio login type: Token Nov 27 22:52:39 volumioben volumio[4772]: info: CoreStateMachine::startPlaybackTimer Nov 27 22:52:39 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:39 volumioben volumio[4772]: info: CoreStateMachine::pushState Nov 27 22:52:39 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:39 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 22:52:39 volumioben volumio[4772]: info: CoreCommandRouter::volumioPushState Nov 27 22:52:51 volumioben volumio[4772]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben sudo[6956]: volumio : unable to resolve host volumioben Nov 27 22:52:51 volumioben sudo[6956]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Nov 27 22:52:51 volumioben sudo[6956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 22:52:51 volumioben sudo[6956]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 22:52:51 volumioben sudo[6958]: volumio : unable to resolve host volumioben Nov 27 22:52:51 volumioben sudo[6958]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Nov 27 22:52:51 volumioben sudo[6956]: pam_unix(sudo:session): session closed for user root Nov 27 22:52:51 volumioben sudo[6958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 22:52:51 volumioben sudo[6958]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 22:52:51 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 22:52:51 volumioben volumio[4772]: info: MPD Permissions set Nov 27 22:52:51 volumioben systemd[1]: Stopping Music Player Daemon... Nov 27 22:52:51 volumioben systemd[1]: mpd.service: Succeeded. Nov 27 22:52:51 volumioben systemd[1]: Stopped Music Player Daemon. Nov 27 22:52:51 volumioben systemd[1]: Starting Music Player Daemon... Nov 27 22:52:51 volumioben sudo[6965]: root : unable to resolve host volumioben Nov 27 22:52:51 volumioben sudo[6965]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Nov 27 22:52:51 volumioben sudo[6965]: sudo: unable to resolve host volumioben: System error Nov 27 22:52:51 volumioben sudo[6965]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 27 22:52:51 volumioben sudo[6965]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 22:52:51 volumioben sudo[6965]: pam_unix(sudo:session): session closed for user root Nov 27 22:52:53 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:53 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:53 volumioben volumio[4772]: info: Prefetching next song Nov 27 22:52:53 volumioben volumio[4772]: info: Doing Prefetch in UPNP Nov 27 22:52:53 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.74:10243/WMPNSSv4/2768834716/0_MTRfOTc5ZDlmNmNfYTdmMzM1NzgtMjEzMA.mp3" Nov 27 22:52:53 volumioben mpd[6982]: Nov 27 22:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 27 22:52:53 volumioben systemd[1]: Started Music Player Daemon. Nov 27 22:52:53 volumioben sudo[6958]: pam_unix(sudo:session): session closed for user root Nov 27 22:52:53 volumioben volumio[4772]: error: updateQueue error: null Nov 27 22:52:56 volumioben volumio[4772]: info: CoreCommandRouter::volumioGetState Nov 27 22:52:56 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:57 volumioben volumio[4772]: info: CoreCommandRouter::volumioPlay Nov 27 22:52:57 volumioben volumio[4772]: info: CoreStateMachine::play index undefined Nov 27 22:52:57 volumioben volumio[4772]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 22:52:57 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:57 volumioben volumio[4772]: info: CoreStateMachine::startPlaybackTimer Nov 27 22:52:57 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:52:57 volumioben volumio[4772]: info: [1732719177391] ControllerUPNPBrowser::clearAddPlayTrack Nov 27 22:52:57 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 22:52:57 volumioben volumio[4772]: info: sendMpdCommand stop took 2 milliseconds Nov 27 22:52:57 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 22:52:57 volumioben volumio[4772]: info: Nov 27 22:52:57 volumioben volumio[4772]: ---------------------------- MPD announces system playlist update Nov 27 22:52:57 volumioben volumio[4772]: info: Ignoring MPD Status Update Nov 27 22:52:57 volumioben volumio[4772]: info: sendMpdCommand clear took 3 milliseconds Nov 27 22:52:57 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.1.74:10243/WMPNSSv4/2768834716/0_MTRfOTc5ZDlmNmNfYTdmMzM1NzgtMjEzMA.mp3" Nov 27 22:52:57 volumioben volumio[4772]: error: updateQueue error: null Nov 27 22:52:57 volumioben volumio[4772]: info: ------------------------------ 6ms Nov 27 22:53:05 volumioben volumio[4772]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 27 22:53:05 volumioben volumio[4772]: info: Retrying Login Due to Network Error Nov 27 22:53:07 volumioben systemd[1]: Stopping Music Player Daemon... Nov 27 22:53:07 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.74:10243/WMPNSSv4/2768834716/0_MTRfOTc5ZDlmNmNfYTdmMzM1NzgtMjEzMA.mp3" Nov 27 22:53:07 volumioben volumio[4772]: error: MPD error: Error: write EPIPE Nov 27 22:53:07 volumioben volumio[4772]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Nov 27 22:53:07 volumioben systemd[1]: mpd.service: Succeeded. Nov 27 22:53:07 volumioben systemd[1]: Stopped Music Player Daemon. Nov 27 22:53:07 volumioben systemd[1]: Starting Music Player Daemon... Nov 27 22:53:07 volumioben sudo[7007]: root : unable to resolve host volumioben Nov 27 22:53:07 volumioben sudo[7007]: sudo: unable to resolve host volumioben: System error Nov 27 22:53:07 volumioben sudo[7007]: root : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Nov 27 22:53:07 volumioben sudo[7007]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 27 22:53:07 volumioben sudo[7007]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 22:53:07 volumioben sudo[7007]: pam_unix(sudo:session): session closed for user root Nov 27 22:53:09 volumioben mpd[7012]: Nov 27 22:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 27 22:53:09 volumioben systemd[1]: Started Music Player Daemon. Nov 27 22:53:09 volumioben mpd_monitor.sh[650]: MPD restarted due to no mpc output. Nov 27 22:53:11 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:11 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:11 volumioben volumio[4772]: info: Prefetching next song Nov 27 22:53:11 volumioben volumio[4772]: info: Doing Prefetch in UPNP Nov 27 22:53:11 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.74:10243/WMPNSSv4/2768834716/0_MTRfOTc5ZDlmNmNfYTdmMzM1NzgtMjEzMA.mp3" Nov 27 22:53:15 volumioben volumio[4772]: info: MyVolumio login type: Token Nov 27 22:53:15 volumioben volumio[4772]: info: CoreStateMachine::startPlaybackTimer Nov 27 22:53:15 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:16 volumioben volumio[4772]: info: CoreStateMachine::pushState Nov 27 22:53:16 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:16 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 22:53:16 volumioben volumio[4772]: info: CoreCommandRouter::volumioPushState Nov 27 22:53:29 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:29 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:29 volumioben volumio[4772]: info: Prefetching next song Nov 27 22:53:29 volumioben volumio[4772]: info: Doing Prefetch in UPNP Nov 27 22:53:29 volumioben volumio[4772]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.1.74:10243/WMPNSSv4/2768834716/0_MTRfOTc5ZDlmNmNfYTdmMzM1NzgtMjEzMA.mp3" Nov 27 22:53:34 volumioben volumio[4772]: info: CoreStateMachine::startPlaybackTimer Nov 27 22:53:34 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:34 volumioben volumio[4772]: info: CoreStateMachine::pushState Nov 27 22:53:34 volumioben volumio[4772]: info: CorePlayQueue::getTrack 0 Nov 27 22:53:34 volumioben volumio[4772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 22:53:34 volumioben volumio[4772]: info: CoreCommandRouter::volumioPushState Nov 27 22:53:41 volumioben volumio[4772]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 22:53:41 volumioben volumio[4772]: Error: connect ETIMEDOUT 185.60.216.36:80 Nov 27 22:53:41 volumioben volumio[4772]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 27 22:53:41 volumioben volumio[4772]: errno: -110, Nov 27 22:53:41 volumioben volumio[4772]: code: 'ETIMEDOUT', Nov 27 22:53:41 volumioben volumio[4772]: syscall: 'connect', Nov 27 22:53:41 volumioben volumio[4772]: address: '185.60.216.36', Nov 27 22:53:41 volumioben volumio[4772]: port: 80 Nov 27 22:53:41 volumioben volumio[4772]: } Nov 27 22:53:41 volumioben volumio[4772]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 22:53:41 volumioben sudo[7078]: volumio : unable to resolve host volumioben Nov 27 22:53:41 volumioben sudo[7078]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Nov 27 22:53:41 volumioben sudo[7078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 22:52 Nov 27 22:53:41 volumioben sudo[7078]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"