-- Logs begin at Sat 2025-05-17 06:13:18 UTC, end at Sat 2025-05-17 06:47:38 UTC. -- May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 06:46:04 rubyaudio volumio[6392]: info: Discovery: Getting this device information May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:04 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:04 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 06:46:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 06:46:07 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:07 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:07 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:07 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:07 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 06:46:07 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 06:46:07 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:07 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:08 rubyaudio sudo[6664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 17 06:46:08 rubyaudio sudo[6664]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:08 rubyaudio sudo[6664]: pam_unix(sudo:session): session closed for user root May 17 06:46:08 rubyaudio sudo[6667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 06:46:08 rubyaudio sudo[6667]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:08 rubyaudio sudo[6667]: pam_unix(sudo:session): session closed for user root May 17 06:46:08 rubyaudio sudo[6673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 17 06:46:08 rubyaudio sudo[6673]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:08 rubyaudio sudo[6673]: pam_unix(sudo:session): session closed for user root May 17 06:46:08 rubyaudio sudo[6675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 17 06:46:08 rubyaudio sudo[6675]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:08 rubyaudio sudo[6675]: pam_unix(sudo:session): session closed for user root May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:12 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 17 06:46:12 rubyaudio volumio[6392]: info: Listing playlists May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:12 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:12 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 17 06:46:12 rubyaudio volumio[6392]: info: Listing playlists May 17 06:46:16 rubyaudio volumio[6392]: info: VolumeController::SetAlsaVolume80 May 17 06:46:16 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:16 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:16 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:16 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:16 rubyaudio volumio[6392]: info: VolumeController::SetAlsaVolume100 May 17 06:46:16 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:16 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:16 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:16 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:18 rubyaudio volumio[6392]: info: VolumeController::SetAlsaVolume90 May 17 06:46:18 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:18 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:18 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:18 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:18 rubyaudio volumio[6392]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Quang%20Dung/ec340378-a47a-440e-9f71-ab84d863bbc3.jpg' May 17 06:46:18 rubyaudio volumio[6392]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hong%20Nhung/540003b1-3e81-423d-a0f8-f010df75ed8a.jpg' May 17 06:46:18 rubyaudio volumio[6392]: info: VolumeController::SetAlsaVolume85 May 17 06:46:18 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:18 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:18 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:18 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:25 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetVisibleSources May 17 06:46:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 17 06:46:25 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetQueue May 17 06:46:25 rubyaudio volumio[6392]: info: CoreStateMachine::getQueue May 17 06:46:25 rubyaudio volumio[6392]: info: CorePlayQueue::getQueue May 17 06:46:27 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 17 06:46:27 rubyaudio volumio[6392]: info: CURURI: music-library May 17 06:46:27 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 17 06:46:27 rubyaudio volumio[6392]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 17 06:46:27 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 17 06:46:27 rubyaudio volumio[6392]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio May 17 06:46:27 rubyaudio volumio[6392]: info: Received Get System Version May 17 06:46:27 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 17 06:46:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 06:46:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 06:46:34 rubyaudio volumio[6392]: info: Discovery: Getting this device information May 17 06:46:34 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:34 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 17 06:46:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:46:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:46:35 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::getUIConfigOnPlugin May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 17 06:46:41 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 17 06:46:51 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:46:51 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:51 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 17 06:46:51 rubyaudio volumio[6392]: info: Listing playlists May 17 06:46:51 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetVisibleSources May 17 06:46:51 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 17 06:46:51 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetQueue May 17 06:46:51 rubyaudio volumio[6392]: info: CoreStateMachine::getQueue May 17 06:46:51 rubyaudio volumio[6392]: info: CorePlayQueue::getQueue May 17 06:46:52 rubyaudio volumio[6392]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:46:52 rubyaudio volumio[6392]: info: Output device has changed, restarting MPD May 17 06:46:52 rubyaudio volumio[6392]: info: Output device has changed, restarting Shairport Sync May 17 06:46:52 rubyaudio sudo[6803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 17 06:46:52 rubyaudio sudo[6803]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:52 rubyaudio sudo[6803]: pam_unix(sudo:session): session closed for user root May 17 06:46:52 rubyaudio sudo[6807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 17 06:46:52 rubyaudio sudo[6807]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:52 rubyaudio systemd[1]: Stopping Music Player Daemon... May 17 06:46:52 rubyaudio volumio[6392]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:46:52 rubyaudio volumio[6392]: info: Found match in Cards Database: setting mixer for card Analog Out May 17 06:46:52 rubyaudio volumio[6392]: info: Found match in Cards Database: setting mixer for card Analog Out May 17 06:46:52 rubyaudio volumio[6392]: info: Setting mixer Master for card Analog Out May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 17 06:46:52 rubyaudio volumio[6392]: info: Updating Volume Controller Parameters: Device: 1,0 Name: Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::getUIConfigOnPlugin May 17 06:46:52 rubyaudio volumio[6392]: info: MPD Permissions set May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 17 06:46:52 rubyaudio volumio[6392]: info: Starting Shairport Sync May 17 06:46:52 rubyaudio sudo[6830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 17 06:46:52 rubyaudio sudo[6830]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:52 rubyaudio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 17 06:46:52 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:46:52 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:52 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:52 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:52 rubyaudio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 17 06:46:52 rubyaudio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 17 06:46:52 rubyaudio sudo[6830]: pam_unix(sudo:session): session closed for user root May 17 06:46:52 rubyaudio volumio[6392]: info: Shairport-Sync Started May 17 06:46:52 rubyaudio volumio[6392]: error: Upnp client error: Error: This socket has been ended by the other party May 17 06:46:53 rubyaudio systemd[1]: Starting Music Player Daemon... May 17 06:46:53 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:46:55 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 17 06:46:55 rubyaudio volumio[6392]: info: CoreStateMachine::getcurrentVolume May 17 06:46:55 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrievevolume May 17 06:46:55 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:46:55 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:55 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:55 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:55 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:55 rubyaudio volumio[6392]: info: CoreStateMachine::updateTrackBlock May 17 06:46:55 rubyaudio volumio[6392]: info: CorePlayQueue::getTrackBlock May 17 06:46:55 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrievevolume May 17 06:46:55 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:46:55 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:55 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:55 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:55 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:56 rubyaudio volumio[6392]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:46:56 rubyaudio volumio[6392]: info: Output device has changed, restarting MPD May 17 06:46:56 rubyaudio volumio[6392]: info: Output device has changed, restarting Shairport Sync May 17 06:46:56 rubyaudio sudo[6854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 17 06:46:56 rubyaudio sudo[6854]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:56 rubyaudio sudo[6855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 17 06:46:56 rubyaudio sudo[6854]: pam_unix(sudo:session): session closed for user root May 17 06:46:56 rubyaudio volumio[6392]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 17 06:46:56 rubyaudio sudo[6855]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:46:56 rubyaudio volumio[6392]: info: Found match in Cards Database: setting mixer for card Analog Out May 17 06:46:56 rubyaudio volumio[6392]: info: Found match in Cards Database: setting mixer for card Analog Out May 17 06:46:56 rubyaudio systemd[1]: Stopping Music Player Daemon... May 17 06:46:56 rubyaudio volumio[6392]: info: Setting mixer Master for card Analog Out May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 17 06:46:56 rubyaudio volumio[6392]: info: Updating Volume Controller Parameters: Device: 1,0 Name: Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::getUIConfigOnPlugin May 17 06:46:56 rubyaudio volumio[6392]: info: MPD Permissions set May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 17 06:46:56 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 17 06:46:57 rubyaudio volumio[6392]: info: Starting Shairport Sync May 17 06:46:57 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:46:57 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:57 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:57 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:57 rubyaudio sudo[6880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 17 06:46:57 rubyaudio sudo[6880]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:46:57 rubyaudio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 17 06:46:57 rubyaudio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 17 06:46:57 rubyaudio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 17 06:46:57 rubyaudio sudo[6880]: pam_unix(sudo:session): session closed for user root May 17 06:46:57 rubyaudio volumio[6392]: info: Shairport-Sync Started May 17 06:46:59 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:46:59 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 17 06:46:59 rubyaudio volumio[6392]: info: CoreStateMachine::getcurrentVolume May 17 06:46:59 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrievevolume May 17 06:46:59 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:46:59 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:59 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:59 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:59 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:46:59 rubyaudio volumio[6392]: info: CoreStateMachine::updateTrackBlock May 17 06:46:59 rubyaudio volumio[6392]: info: CorePlayQueue::getTrackBlock May 17 06:46:59 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrievevolume May 17 06:46:59 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:46:59 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:46:59 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:46:59 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:46:59 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:47:03 rubyaudio volumio[6392]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:47:03 rubyaudio volumio[6392]: info: Output device has changed, restarting MPD May 17 06:47:03 rubyaudio volumio[6392]: info: Output device has changed, restarting Shairport Sync May 17 06:47:03 rubyaudio sudo[6901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 17 06:47:03 rubyaudio sudo[6901]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:47:03 rubyaudio sudo[6899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 17 06:47:03 rubyaudio sudo[6899]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:47:03 rubyaudio sudo[6899]: pam_unix(sudo:session): session closed for user root May 17 06:47:03 rubyaudio volumio[6392]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:47:03 rubyaudio volumio[6392]: info: Found match in Cards Database: setting mixer for card Analog Out May 17 06:47:03 rubyaudio volumio[6392]: info: Found match in Cards Database: setting mixer for card Analog Out May 17 06:47:03 rubyaudio volumio[6392]: info: Setting mixer Master for card Analog Out May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 17 06:47:03 rubyaudio volumio[6392]: info: Updating Volume Controller Parameters: Device: 1,0 Name: Mixer: Master Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::getUIConfigOnPlugin May 17 06:47:03 rubyaudio volumio[6392]: info: MPD Permissions set May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 17 06:47:03 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 17 06:47:04 rubyaudio volumio[6392]: info: Starting Shairport Sync May 17 06:47:04 rubyaudio sudo[6926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 17 06:47:04 rubyaudio sudo[6926]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:47:04 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:47:04 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:47:04 rubyaudio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 17 06:47:04 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:47:04 rubyaudio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... May 17 06:47:04 rubyaudio sudo[6926]: pam_unix(sudo:session): session closed for user root May 17 06:47:04 rubyaudio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 17 06:47:04 rubyaudio volumio[6392]: info: Shairport-Sync Started May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 06:47:04 rubyaudio volumio[6392]: info: Discovery: Getting this device information May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:47:04 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:47:04 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:05 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:06 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 17 06:47:06 rubyaudio volumio[6392]: info: CoreStateMachine::getcurrentVolume May 17 06:47:06 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrievevolume May 17 06:47:06 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:47:06 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:47:06 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:47:06 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:47:06 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:47:06 rubyaudio volumio[6392]: info: CoreStateMachine::updateTrackBlock May 17 06:47:06 rubyaudio volumio[6392]: info: CorePlayQueue::getTrackBlock May 17 06:47:06 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioRetrievevolume May 17 06:47:06 rubyaudio volumio[6392]: info: VolumeController:: Volume=41 Mute =false May 17 06:47:06 rubyaudio volumio[6392]: info: CoreStateMachine::pushState May 17 06:47:06 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:47:06 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioPushState May 17 06:47:06 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 17 06:47:06 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:07 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:07 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:08 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:09 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:09 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:09 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:09 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:09 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:09 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:10 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:15 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:15 rubyaudio systemd[1]: Starting Music Player Daemon... May 17 06:47:16 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:18 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:21 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:22 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:23 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:24 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:25 rubyaudio systemd[1]: Started Music Player Daemon. May 17 06:47:25 rubyaudio sudo[6855]: pam_unix(sudo:session): session closed for user root May 17 06:47:25 rubyaudio sudo[6901]: pam_unix(sudo:session): session closed for user root May 17 06:47:25 rubyaudio sudo[6807]: pam_unix(sudo:session): session closed for user root May 17 06:47:25 rubyaudio volumio[6392]: error: MPD error: false == true May 17 06:47:25 rubyaudio volumio[6392]: error: MPD error: false == true May 17 06:47:25 rubyaudio volumio[6392]: error: updateQueue error: null May 17 06:47:25 rubyaudio volumio[6392]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio sudo[6973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 17 06:47:25 rubyaudio sudo[6973]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio sudo[6973]: pam_unix(sudo:session): session closed for user root May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio sudo[6976]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 17 06:47:25 rubyaudio sudo[6976]: pam_unix(sudo:session): session opened for user root by (uid=0) May 17 06:47:25 rubyaudio systemd[1]: Stopping Music Player Daemon... May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 17 06:47:25 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 17 06:47:25 rubyaudio volumio[6392]: info: MPD Permissions set May 17 06:47:25 rubyaudio systemd[1]: Starting Music Player Daemon... May 17 06:47:25 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:26 rubyaudio volumio[6392]: error: Upnp client error: Error: This socket has been ended by the other party May 17 06:47:28 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:31 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:32 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:33 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 17 06:47:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 17 06:47:34 rubyaudio volumio[6392]: info: Discovery: Getting this device information May 17 06:47:34 rubyaudio volumio[6392]: info: CoreCommandRouter::volumioGetState May 17 06:47:34 rubyaudio volumio[6392]: info: CorePlayQueue::getTrack 0 May 17 06:47:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses May 17 06:47:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:47:34 rubyaudio volumio[6392]: info: CoreCommandRouter::executeOnPlugin: system , getConf May 17 06:47:35 rubyaudio ntfs-3g[826]: Failed to open index bitmap attribute: No such file or directory May 17 06:47:35 rubyaudio systemd[1]: Started Music Player Daemon. May 17 06:47:35 rubyaudio sudo[6976]: pam_unix(sudo:session): session closed for user root May 17 06:47:35 rubyaudio volumio[6392]: error: MPD error: false == true May 17 06:47:35 rubyaudio volumio[6392]: error: updateQueue error: null May 17 06:47:35 rubyaudio volumio[6392]: error: updateQueue error: null May 17 06:47:38 rubyaudio volumio[6392]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 17 06:47:38 rubyaudio volumio[6392]: { Error: connect ETIMEDOUT 151.101.78.79:80 May 17 06:47:38 rubyaudio volumio[6392]: at Object._errnoException (util.js:1022:11) May 17 06:47:38 rubyaudio volumio[6392]: at _exceptionWithHostPort (util.js:1044:20) May 17 06:47:38 rubyaudio volumio[6392]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 17 06:47:38 rubyaudio volumio[6392]: code: 'ETIMEDOUT', May 17 06:47:38 rubyaudio volumio[6392]: errno: 'ETIMEDOUT', May 17 06:47:38 rubyaudio volumio[6392]: syscall: 'connect', May 17 06:47:38 rubyaudio volumio[6392]: address: '151.101.78.79', May 17 06:47:38 rubyaudio volumio[6392]: port: 80 } May 17 06:47:38 rubyaudio volumio[6392]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 17 06:47:38 rubyaudio sudo[6999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-17 06:46 May 17 06:47:38 rubyaudio sudo[6999]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 11:49:13 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="x86" VOLUMIO_HASH="62511ec23417b6085328d5bda7373a0c"