-- Logs begin at Thu 2019-02-14 08:11:59 -02, end at Sun 2025-01-12 16:36:25 -03. -- Jan 12 16:35:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:35:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:35:09 volumio volumio[1001]: info: Discovery: Getting this device information Jan 12 16:35:09 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:35:09 volumio volumio[1001]: verbose: New Socket.io Connection to 192.168.2.51:3000 from 192.168.2.10 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Jan 12 16:35:09 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 16:35:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 16:35:09 volumio systemd[1]: Starting Cleanup of Temporary Directories... Jan 12 16:35:09 volumio volumio[1001]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 12 16:35:09 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded. Jan 12 16:35:09 volumio systemd[1]: Started Cleanup of Temporary Directories. Jan 12 16:35:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:35:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:35:10 volumio volumio[1001]: info: Discovery: Getting this device information Jan 12 16:35:10 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:35:35 volumio sudo[3904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:35:35 volumio sudo[3904]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:35 volumio sudo[3904]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:35 volumio sudo[3907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:35:35 volumio sudo[3907]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:35 volumio sudo[3907]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:35 volumio volumio[1001]: verbose: New Socket.io Connection to 192.168.2.51 from 192.168.2.10 UA: Mozilla/5.0 (Linux; Android 14; 2211133G Build/UKQ1.230804.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.200 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:35:35 volumio volumio[1001]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:35:35 volumio sudo[3911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:35:35 volumio sudo[3911]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:35 volumio sudo[3911]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:35 volumio sudo[3913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:35:35 volumio sudo[3913]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:35 volumio sudo[3913]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:35 volumio volumio[1001]: verbose: New Socket.io Connection to 192.168.2.51 from 192.168.2.10 UA: Mozilla/5.0 (Linux; Android 14; 2211133G Build/UKQ1.230804.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.200 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:35:35 volumio volumio[1001]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 12 16:35:35 volumio volumio[1001]: info: Listing playlists Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 16:35:35 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:35:39 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:35:39 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:35:39 volumio volumio[1001]: info: Discovery: Getting this device information Jan 12 16:35:39 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:39 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:35:49 volumio sudo[3951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:35:49 volumio sudo[3951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:49 volumio sudo[3951]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:49 volumio sudo[3953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:35:49 volumio sudo[3953]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:49 volumio sudo[3953]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:49 volumio volumio[1001]: verbose: New Socket.io Connection to 192.168.2.51 from 192.168.2.10 UA: Mozilla/5.0 (Linux; Android 14; 2211133G Build/UKQ1.230804.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.200 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::volumioGetVisibleSources Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:35:49 volumio volumio[1001]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:35:49 volumio sudo[3957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 12 16:35:49 volumio sudo[3957]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:49 volumio sudo[3957]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:49 volumio sudo[3959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 12 16:35:49 volumio sudo[3959]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 12 16:35:49 volumio sudo[3959]: pam_unix(sudo:session): session closed for user root Jan 12 16:35:49 volumio volumio[1001]: verbose: New Socket.io Connection to 192.168.2.51 from 192.168.2.10 UA: Mozilla/5.0 (Linux; Android 14; 2211133G Build/UKQ1.230804.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/131.0.6778.200 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 12 16:35:49 volumio volumio[1001]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jan 12 16:35:49 volumio volumio[1001]: info: Listing playlists Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 12 16:35:49 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:35:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:35:55 volumio volumio[1001]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 12 16:35:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 12 16:35:55 volumio volumio[1001]: info: Received Get System Version Jan 12 16:35:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 16:35:55 volumio volumio[1001]: info: Received Get System Info Jan 12 16:35:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:35:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:35:55 volumio volumio[1001]: info: Discovery: Getting this device information Jan 12 16:35:55 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:35:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: Jan 12 16:35:58 volumio volumio[1001]: ---------------------------- Client requests Volume 35 Jan 12 16:35:58 volumio volumio[1001]: info: VolumeController::SetAlsaVolume35 Jan 12 16:35:58 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:58 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:58 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:58 volumio volumio[1001]: info: Jan 12 16:35:58 volumio volumio[1001]: ---------------------------- Client requests Volume 32 Jan 12 16:35:58 volumio volumio[1001]: info: VolumeController::SetAlsaVolume32 Jan 12 16:35:58 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:58 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:58 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 38 Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 35 Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:35:58 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 35 Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 32 Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 35 Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 32 Jan 12 16:35:58 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:35:58 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 32 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:58 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:58 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:35:58 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:35:58 volumio volumio[1001]: info: Jan 12 16:35:58 volumio volumio[1001]: ---------------------------- Client requests Volume 29 Jan 12 16:35:58 volumio volumio[1001]: info: VolumeController::SetAlsaVolume29 Jan 12 16:35:58 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:58 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:58 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:58 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:35:59 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 Jan 12 16:35:59 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 32 Jan 12 16:35:59 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 29 Jan 12 16:35:59 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:35:59 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 29 Jan 12 16:35:59 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:35:59 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 16 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume16 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 15 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume15 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 14 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume14 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 13 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume13 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 12 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume12 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 11 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume11 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 10 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume10 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 9 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume9 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:35:59 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 8 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume8 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 9 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume9 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:35:59 volumio volumio[1001]: info: Jan 12 16:35:59 volumio volumio[1001]: ---------------------------- Client requests Volume 10 Jan 12 16:35:59 volumio volumio[1001]: info: VolumeController::SetAlsaVolume10 Jan 12 16:35:59 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:35:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:35:59 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 14 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume14 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 16 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume16 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 19 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume19 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 21 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume21 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 24 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume24 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 27 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume27 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 30 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume30 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 29 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 15 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 15 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 13 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 13 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 12 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 12 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 12 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 12 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 11 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 12 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 9 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 9 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 8 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 8 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 8 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 9 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 8 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 9 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 8 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 10 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 14 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 19 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 16 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 19 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 19 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 21 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 19 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 21 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 21 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 21 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 24 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 24 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 27 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 24 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 27 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 27 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 30 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 27 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 30 Jan 12 16:36:00 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:00 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 30 Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 32 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume32 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 37 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume37 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 43 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume43 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:00 volumio volumio[1001]: info: Jan 12 16:36:00 volumio volumio[1001]: ---------------------------- Client requests Volume 45 Jan 12 16:36:00 volumio volumio[1001]: info: VolumeController::SetAlsaVolume45 Jan 12 16:36:00 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:00 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:00 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 50 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume50 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 52 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume52 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 54 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume54 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 56 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume56 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 57 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume57 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 59 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume59 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 60 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume60 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 62 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume62 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: info: Jan 12 16:36:01 volumio volumio[1001]: ---------------------------- Client requests Volume 63 Jan 12 16:36:01 volumio volumio[1001]: info: VolumeController::SetAlsaVolume63 Jan 12 16:36:01 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:01 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:01 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 32 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 30 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 32 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 32 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 37 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 32 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 37 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 37 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 43 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 37 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 43 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 43 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 43 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 45 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 45 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 45 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 50 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 50 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 50 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 52 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 52 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 54 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 52 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 54 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 54 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 54 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 56 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 56 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 57 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 56 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 57 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 56 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 59 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 59 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 59 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 60 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 59 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 62 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:01 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 62 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 63 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 62 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 63 Jan 12 16:36:01 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:01 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:02 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:02 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:02 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:02 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:02 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:03 volumio volumio[1001]: SPOTIFY: SETTING SPOTIFY VOLUME 62 Jan 12 16:36:03 volumio volumio[1001]: info: Sending Spotify command with payload to local API: /player/volume Jan 12 16:36:03 volumio go-librespot[1192]: time="2025-01-12T16:36:03-03:00" level=debug msg="update volume to 40631/65535" Jan 12 16:36:03 volumio go-librespot[1192]: time="2025-01-12T16:36:03-03:00" level=debug msg="put connect state because VOLUME_CHANGED" Jan 12 16:36:03 volumio go-librespot[1192]: time="2025-01-12T16:36:03-03:00" level=trace msg="emitting websocket event: volume" Jan 12 16:36:03 volumio volumio[1001]: SPOTIFY: received: {"type":"volume","data":{"value":62,"max":100}} Jan 12 16:36:03 volumio volumio[1001]: SPOTIFY: RECEIVED SPOTIFY VOLUME 62 Jan 12 16:36:07 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 12 16:36:07 volumio volumio[1001]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 12 16:36:07 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 12 16:36:07 volumio volumio[1001]: info: Received Get System Version Jan 12 16:36:07 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 12 16:36:07 volumio volumio[1001]: info: Received Get System Info Jan 12 16:36:07 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:36:07 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:36:07 volumio volumio[1001]: info: Discovery: Getting this device information Jan 12 16:36:07 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:36:07 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: info: Jan 12 16:36:08 volumio volumio[1001]: ---------------------------- Client requests Volume 62 Jan 12 16:36:08 volumio volumio[1001]: info: VolumeController::SetAlsaVolume62 Jan 12 16:36:08 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:08 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jan 12 16:36:08 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:08 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:08 volumio volumio[1001]: info: Jan 12 16:36:08 volumio volumio[1001]: ---------------------------- Client requests Volume 67 Jan 12 16:36:08 volumio volumio[1001]: info: VolumeController::SetAlsaVolume67 Jan 12 16:36:08 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:08 volumio volumio[1001]: info: Jan 12 16:36:08 volumio volumio[1001]: ---------------------------- Client requests Volume 71 Jan 12 16:36:08 volumio volumio[1001]: info: VolumeController::SetAlsaVolume71 Jan 12 16:36:08 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:08 volumio volumio[1001]: info: Jan 12 16:36:08 volumio volumio[1001]: ---------------------------- Client requests Volume 73 Jan 12 16:36:08 volumio volumio[1001]: info: VolumeController::SetAlsaVolume73 Jan 12 16:36:08 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:08 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:08 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:08 volumio volumio[1001]: info: Jan 12 16:36:08 volumio volumio[1001]: ---------------------------- Client requests Volume 74 Jan 12 16:36:08 volumio volumio[1001]: info: VolumeController::SetAlsaVolume74 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 75 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume75 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 76 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume76 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 67 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 62 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 67 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:09 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 67 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 71 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 67 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 71 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:09 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 71 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 71 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 73 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:09 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 73 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 73 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 74 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 75 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 73 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 75 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:09 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 75 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 75 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 76 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 77 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume77 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 78 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume78 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 78 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume78 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 78 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume78 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 77 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 75 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 77 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:09 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 77 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 77 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 78 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 77 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 78 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 77 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 78 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 12 16:36:09 volumio volumio[1001]: info: Discovery: Getting this device information Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 86 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume86 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 77 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 86 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:09 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 86 Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 82 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume82 Jan 12 16:36:09 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:09 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:09 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 82 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 86 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 82 Jan 12 16:36:09 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:09 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 82 Jan 12 16:36:09 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:09 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:09 volumio volumio[1001]: info: Jan 12 16:36:09 volumio volumio[1001]: ---------------------------- Client requests Volume 81 Jan 12 16:36:09 volumio volumio[1001]: info: VolumeController::SetAlsaVolume81 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Jan 12 16:36:10 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 82 Jan 12 16:36:10 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 81 Jan 12 16:36:10 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:10 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:10 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 80 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume80 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 79 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume79 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 78 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume78 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 76 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume76 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 74 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume74 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 72 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume72 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 70 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume70 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 68 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume68 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , setRemoteDeviceVolume Jan 12 16:36:10 volumio volumio[1001]: info: Setting Remote Device Volume: http://192.168.2.51 Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 65 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume65 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 63 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume63 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 62 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume62 Jan 12 16:36:10 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:10 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:10 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:10 volumio volumio[1001]: info: Jan 12 16:36:10 volumio volumio[1001]: ---------------------------- Client requests Volume 61 Jan 12 16:36:10 volumio volumio[1001]: info: VolumeController::SetAlsaVolume61 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 60 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume60 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 59 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume59 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 58 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume58 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 57 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume57 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 56 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume56 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 55 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume55 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 53 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume53 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 82 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 80 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 80 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 80 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 79 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 80 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 78 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 78 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 76 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 78 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 76 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 76 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 76 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 74 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 74 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 72 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 74 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 72 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 72 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 72 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 70 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 70 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 70 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 68 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 68 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 65 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 68 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 65 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 65 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 63 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 65 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 63 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 63 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 62 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 63 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 62 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 63 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 61 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 61 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 60 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 61 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 60 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 61 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 59 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 59 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 59 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 58 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 57 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 59 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 57 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 57 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 57 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 56 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 57 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 55 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 55 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 53 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 55 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 53 Jan 12 16:36:11 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:11 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 53 Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 52 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume52 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 51 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume51 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 50 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume50 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Jan 12 16:36:11 volumio volumio[1001]: ---------------------------- Client requests Volume 49 Jan 12 16:36:11 volumio volumio[1001]: info: VolumeController::SetAlsaVolume49 Jan 12 16:36:11 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:11 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:11 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:11 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: info: Jan 12 16:36:12 volumio volumio[1001]: ---------------------------- Client requests Volume 48 Jan 12 16:36:12 volumio volumio[1001]: info: VolumeController::SetAlsaVolume48 Jan 12 16:36:12 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:12 volumio volumio[1001]: info: Jan 12 16:36:12 volumio volumio[1001]: ---------------------------- Client requests Volume 47 Jan 12 16:36:12 volumio volumio[1001]: info: VolumeController::SetAlsaVolume47 Jan 12 16:36:12 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:12 volumio volumio[1001]: info: Jan 12 16:36:12 volumio volumio[1001]: ---------------------------- Client requests Volume 46 Jan 12 16:36:12 volumio volumio[1001]: info: VolumeController::SetAlsaVolume46 Jan 12 16:36:12 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:12 volumio volumio[1001]: info: Jan 12 16:36:12 volumio volumio[1001]: ---------------------------- Client requests Volume 45 Jan 12 16:36:12 volumio volumio[1001]: info: VolumeController::SetAlsaVolume45 Jan 12 16:36:12 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:12 volumio volumio[1001]: info: Jan 12 16:36:12 volumio volumio[1001]: ---------------------------- Client requests Volume 45 Jan 12 16:36:12 volumio volumio[1001]: info: VolumeController::SetAlsaVolume45 Jan 12 16:36:12 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:12 volumio volumio[1001]: info: Jan 12 16:36:12 volumio volumio[1001]: ---------------------------- Client requests Volume 45 Jan 12 16:36:12 volumio volumio[1001]: info: VolumeController::SetAlsaVolume45 Jan 12 16:36:12 volumio volumio[1001]: info: CoreStateMachine::pushState Jan 12 16:36:12 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output update for this device Jan 12 16:36:12 volumio volumio[1001]: info: MRS: Pushing multiroomSync output Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 52 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 53 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 52 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 53 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 51 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:12 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 51 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 51 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 50 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 49 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 51 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 49 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:12 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 49 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 49 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 48 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 49 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 47 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:12 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 47 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 47 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 46 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: false Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: SPOTIFY VOLUME 47 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: VOLUMIO VOLUME 45 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 12 16:36:12 volumio volumio[1001]: info: Setting Spotify Volume from Volumio: 45 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Jan 12 16:36:12 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 45 Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: info: Done setting volume on: Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:12 volumio volumio[1001]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid MIT-MAGIC-COOKIE-1 keyxcb_connection_has_error() returned true Jan 12 16:36:13 volumio volumio[1001]: SPOTIFY: SETTING SPOTIFY VOLUME 45 Jan 12 16:36:13 volumio volumio[1001]: info: Sending Spotify command with payload to local API: /player/volume Jan 12 16:36:13 volumio go-librespot[1192]: time="2025-01-12T16:36:13-03:00" level=debug msg="update volume to 29490/65535" Jan 12 16:36:14 volumio go-librespot[1192]: time="2025-01-12T16:36:14-03:00" level=debug msg="put connect state because VOLUME_CHANGED" Jan 12 16:36:14 volumio go-librespot[1192]: time="2025-01-12T16:36:14-03:00" level=trace msg="emitting websocket event: volume" Jan 12 16:36:14 volumio volumio[1001]: SPOTIFY: received: {"type":"volume","data":{"value":45,"max":100}} Jan 12 16:36:14 volumio volumio[1001]: SPOTIFY: RECEIVED SPOTIFY VOLUME 45 Jan 12 16:36:25 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Jan 12 16:36:25 volumio volumio[1001]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Jan 12 16:36:25 volumio volumio[1001]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 16:36:25 volumio volumio[1001]: TypeError: Cannot read property 'then' of undefined Jan 12 16:36:25 volumio volumio[1001]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Jan 12 16:36:25 volumio volumio[1001]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2273:30) Jan 12 16:36:25 volumio volumio[1001]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1450:26) Jan 12 16:36:25 volumio volumio[1001]: at Socket.emit (events.js:315:20) Jan 12 16:36:25 volumio volumio[1001]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 12 16:36:25 volumio volumio[1001]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jan 12 16:36:25 volumio volumio[1001]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 12 16:36:25 volumio sudo[4155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-12 16:35 Jan 12 16:36:25 volumio sudo[4155]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"