-- Logs begin at Thu 2019-02-14 07:11:58 -03, end at Tue 2025-05-20 16:01:28 -04. -- May 20 16:00:00 volumio startx[1943]: V3D 7.1 not supported by this version of Mesa. May 20 16:00:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:00 volumio kernel: broken atomic modeset userspace detected, disabling atomic May 20 16:00:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:00 volumio startx[1943]: (II) modeset(0): Initializing kms color map for depth 24, 8 bpc. May 20 16:00:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:01 volumio volumio[1674]: info: touch_display: Setting screensaver timeout to 30 seconds. May 20 16:00:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:01 volumio wpa_supplicant[1153]: wlan0: Trying to associate with SSID 'Matrix_WiFi7' May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:02 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetVisibleSources May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 20 16:00:05 volumio volumio[1674]: info: Received Get System Info May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:05 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:05 volumio volumio[1674]: info: Listing playlists May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 20 16:00:05 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 20 16:00:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:07 volumio systemd[1]: systemd-timedated.service: Succeeded. May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:07 volumio sudo[2401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 20 16:00:07 volumio sudo[2401]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:07 volumio sudo[2401]: pam_unix(sudo:session): session closed for user root May 20 16:00:07 volumio sudo[2404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 20 16:00:07 volumio sudo[2404]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:07 volumio sudo[2404]: pam_unix(sudo:session): session closed for user root May 20 16:00:07 volumio sudo[2407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 20 16:00:07 volumio sudo[2407]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:07 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 20 16:00:07 volumio sudo[2407]: pam_unix(sudo:session): session closed for user root May 20 16:00:07 volumio volumio[1674]: info: Upmpdcli Daemon Started May 20 16:00:07 volumio volumio[2409]: Generating RSA private key, 4096 bit long modulus (2 primes) May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 20 16:00:07 volumio volumio[1674]: info: Received Get System Info May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:07 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 20 16:00:08 volumio volumio[1674]: info: Adding plugin bluetooth to MyMusic Plugins May 20 16:00:08 volumio volumio[1674]: info: Adding plugin multiroom to MyMusic Plugins May 20 16:00:08 volumio volumio[1674]: info: Adding plugin metavolumio to MyMusic Plugins May 20 16:00:08 volumio volumio[1674]: info: Adding plugin cd_controller to MyMusic Plugins May 20 16:00:08 volumio volumio[1674]: info: Adding plugin qobuzconnect to MyMusic Plugins May 20 16:00:08 volumio volumio[1674]: info: Adding plugin smart_inputs to MyMusic Plugins May 20 16:00:08 volumio volumio[1674]: info: Adding plugin tidalconnect to MyMusic Plugins May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:08 volumio volumio[1674]: info: Starting MyVolumio Remote Streaming Endpoints May 20 16:00:08 volumio volumio[1674]: info: MyVolumio login type: Token May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 20 16:00:08 volumio wpa_supplicant[1153]: wlan0: Trying to associate with SSID 'Matrix_WiFi7' May 20 16:00:08 volumio volumio[1674]: info: Starting Streaming Service Transparent Proxy May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 20 16:00:08 volumio volumio[1674]: info: Streaming services startup May 20 16:00:08 volumio volumio[1674]: info: Starting Streaming Daemon May 20 16:00:08 volumio sudo[2435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 20 16:00:08 volumio sudo[2435]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:08 volumio sudo[2435]: pam_unix(sudo:session): session closed for user root May 20 16:00:08 volumio volumio[1674]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 20 16:00:08 volumio volumio[1674]: info: Received Get System Info May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:08 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:08 volumio volumio[1674]: error: Cannot start Volumio Streaming Daemon May 20 16:00:08 volumio volumio[1674]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 20 16:00:08 volumio volumio[1674]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:08 volumio volumio[1674]: STREAMING PROXY: Starting server on port 3245 May 20 16:00:08 volumio volumio[1674]: Node JS runtime: 14 May 20 16:00:09 volumio volumio[1674]: error: MyVolumio Custom Token format not valid, refreshing it May 20 16:00:09 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 May 20 16:00:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:09 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 20 16:00:09 volumio volumio[1674]: info: MyVolumio login type: Token May 20 16:00:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:09 volumio volumio[1674]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 20 16:00:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:09 volumio volumio[1674]: info: MyVolumio login type: Token May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:11 volumio volumio[1674]: info: MyVolumio token set successfully May 20 16:00:11 volumio volumio[1674]: info: MYVOLUMIO: Adding device May 20 16:00:11 volumio volumio[1674]: info: MYVOLUMIO: Evaluating Server May 20 16:00:11 volumio volumio[2409]: ............................................................................++++ May 20 16:00:11 volumio volumio[1674]: info: MyVolumio status changed May 20 16:00:11 volumio volumio[1674]: info: Streaming services startup May 20 16:00:11 volumio volumio[1674]: info: Starting Streaming Daemon May 20 16:00:11 volumio volumio[1674]: info: Removing browser output: myVolumio user plan is not superstar May 20 16:00:11 volumio volumio[1674]: info: Removing audio output: May 20 16:00:11 volumio volumio[1674]: info: Stoppping Tunnel 1 May 20 16:00:11 volumio sudo[2460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 20 16:00:11 volumio sudo[2460]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:11 volumio sudo[2460]: pam_unix(sudo:session): session closed for user root May 20 16:00:11 volumio sudo[2463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service May 20 16:00:11 volumio sudo[2463]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:11 volumio volumio[1674]: error: Cannot start Volumio Streaming Daemon May 20 16:00:11 volumio volumio[1674]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 20 16:00:11 volumio volumio[1674]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 20 16:00:11 volumio sudo[2463]: pam_unix(sudo:session): session closed for user root May 20 16:00:11 volumio volumio[1674]: info: Remote SSH Stopped May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 20 16:00:11 volumio volumio[1674]: info: Received Get System Info May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:11 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:13 volumio volumio[1674]: info: Setting Geolocation for MyVolumio to us1 May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:14 volumio volumio[1674]: info: Updating MyVolumio device info May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:14 volumio volumio[1674]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:14 volumio volumio[2409]: ...............................................................................++++ May 20 16:00:14 volumio volumio[2409]: e is 65537 (0x010001) May 20 16:00:14 volumio volumio[2409]: writing RSA key May 20 16:00:14 volumio volumio[1674]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:15 volumio wpa_supplicant[1153]: wlan0: Trying to associate with SSID 'Matrix_WiFi7' May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:16 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 May 20 16:00:16 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Matrix_WiFi7" auth_failures=1 duration=10 reason=CONN_FAILED May 20 16:00:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: MYVOLUMIO: Adding device May 20 16:00:18 volumio volumio[1674]: info: MYVOLUMIO: Evaluating Server May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:19 volumio volumio[1674]: info: Setting Geolocation for MyVolumio to us1 May 20 16:00:19 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:20 volumio volumio[1674]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 20 16:00:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:20 volumio volumio[1674]: info: Updating MyVolumio device info May 20 16:00:20 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:21 volumio volumio[1674]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 20 16:00:23 volumio volumio[1674]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 20 16:00:24 volumio volumio[1674]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 20 16:00:24 volumio volumio[1674]: info: Received Get System Version May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 16:00:24 volumio volumio[1674]: info: Received Get System Info May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:24 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:27 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Matrix_WiFi7" May 20 16:00:27 volumio wpa_supplicant[1153]: wlan0: Trying to associate with SSID 'Matrix_WiFi7' May 20 16:00:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:27 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 May 20 16:00:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetBrowseSources May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 20 16:00:28 volumio volumio[1674]: error: MyVolumio Plugin failed to authenticate in a timely fashion May 20 16:00:28 volumio volumio[1674]: info: Completed starting MyVolumio Plugin May 20 16:00:28 volumio volumio[1674]: [Metrics] CommandRouter: 36s 67.29ms May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumiosetStartupVolume May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::Close All Modals sent May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::Close All Modals sent May 20 16:00:28 volumio volumio[1674]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav May 20 16:00:28 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:00:28 volumio volumio-remote-updater[789]: No test mode May 20 16:00:28 volumio volumio-remote-updater[789]: No alpha test mode May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:29 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:29 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:29 volumio volumio[1674]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:29 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:29 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:29 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:29 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 20 16:00:29 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:00:29 volumio volumio[1674]: Cannot get aplay -l output: Error: Command failed: /usr/bin/aplay -l May 20 16:00:29 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: raat , onStop May 20 16:00:29 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 20 16:00:30 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:30 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:30 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:30 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:30 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:30 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:30 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:30 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:30 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:30 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:30 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:30 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:31 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:31 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:32 volumio ntpd[1085]: Soliciting pool server 162.159.200.1 May 20 16:00:32 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:32 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:32 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:32 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:32 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:32 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:32 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:32 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:32 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:32 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:32 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:32 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:32 volumio ntpd[1085]: Soliciting pool server 64.176.4.213 May 20 16:00:33 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:33 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:33 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:33 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:33 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:33 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:33 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:33 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:33 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:33 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:33 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:33 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio ntpd[1085]: Soliciting pool server 200.89.75.197 May 20 16:00:34 volumio wpa_supplicant[1153]: wlan0: Trying to associate with SSID 'Matrix_WiFi7' May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 May 20 16:00:34 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Matrix_WiFi7" auth_failures=2 duration=23 reason=CONN_FAILED May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio ntpd[1085]: Soliciting pool server 64.176.3.116 May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:34 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:34 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:35 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:35 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:35 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:35 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:35 volumio ntpd[1085]: Soliciting pool server 200.89.75.198 May 20 16:00:35 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:35 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:35 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:35 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:35 volumio volumio[1674]: info: BOOT COMPLETED May 20 16:00:35 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:35 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:35 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:35 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:35 volumio ntpd[1085]: Soliciting pool server 38.54.20.171 May 20 16:00:36 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:36 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:36 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:36 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:36 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:36 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:36 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:36 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:36 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:36 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:36 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:36 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:36 volumio ntpd[1085]: Soliciting pool server 2a02:c6c1:156:283::21 May 20 16:00:37 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:37 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:37 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:37 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:37 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:37 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:37 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:37 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:37 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:37 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:37 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:37 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio ntpd[1085]: Soliciting pool server 194.0.5.123 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio ntpd[1085]: Soliciting pool server 64.176.13.132 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:38 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:38 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:39 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:39 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:39 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:39 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:39 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:39 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:39 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:39 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:39 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:39 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:39 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:39 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio sudo[2598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 20 16:00:40 volumio sudo[2598]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:40 volumio sudo[2598]: pam_unix(sudo:session): session closed for user root May 20 16:00:40 volumio sudo[2601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 20 16:00:40 volumio sudo[2601]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:40 volumio sudo[2601]: pam_unix(sudo:session): session closed for user root May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: verbose: New Socket.io Connection to 192.168.3.37 from 192.168.3.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 May 20 16:00:40 volumio sudo[2604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 20 16:00:40 volumio sudo[2604]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:40 volumio sudo[2604]: pam_unix(sudo:session): session closed for user root May 20 16:00:40 volumio sudo[2607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 20 16:00:40 volumio sudo[2607]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:00:40 volumio sudo[2607]: pam_unix(sudo:session): session closed for user root May 20 16:00:40 volumio volumio[1674]: verbose: New Socket.io Connection to 192.168.3.37 from 192.168.3.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Edg/136.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetVisibleSources May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 20 16:00:40 volumio volumio[1674]: info: Received Get System Info May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:40 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: Listing playlists May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:40 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:40 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 20 16:00:41 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:41 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:41 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:41 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:41 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:41 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:41 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:41 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:41 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:41 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:41 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:41 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:41 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:41 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:42 volumio ntpd[1085]: receive: Unexpected origin timestamp 0xebd75de9.ec661d89 does not match aorg 0000000000.00000000 from server@38.54.20.171 xmt 0xebd75dea.1ee1bc08 May 20 16:00:42 volumio ntpd[1085]: receive: Unexpected origin timestamp 0xebd75de9.ec695af0 does not match aorg 0000000000.00000000 from server@200.89.75.197 xmt 0xebd75dea.1cf8aa8c May 20 16:00:42 volumio ntpd[1085]: receive: Unexpected origin timestamp 0xebd75de9.ec6a4804 does not match aorg 0000000000.00000000 from server@64.176.4.213 xmt 0xebd75dea.1f261356 May 20 16:00:42 volumio ntpd[1085]: receive: Unexpected origin timestamp 0xebd75de9.ec68a67e does not match aorg 0000000000.00000000 from server@64.176.3.116 xmt 0xebd75dea.1f2cbbcd May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 0 May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioNext May 20 16:00:42 volumio volumio[1674]: info: CoreStateMachine::next May 20 16:00:42 volumio volumio[1674]: info: CoreStateMachine::stop May 20 16:00:42 volumio volumio[1674]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 16:00:42 volumio volumio[1674]: info: CoreStateMachine::play index undefined May 20 16:00:42 volumio volumio[1674]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:42 volumio volumio[1674]: info: CoreStateMachine::startPlaybackTimer May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:42 volumio volumio[1674]: verbose: ControllerMpd::clearAddPlayTracks USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3 May 20 16:00:42 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand stop May 20 16:00:42 volumio volumio[1674]: info: CoreStateMachine::updateTrackBlock May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrackBlock May 20 16:00:42 volumio volumio[1674]: info: sendMpdCommand stop took 1 milliseconds May 20 16:00:42 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand clear May 20 16:00:42 volumio volumio[1674]: info: sendMpdCommand clear took 0 milliseconds May 20 16:00:42 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand add "USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3" May 20 16:00:42 volumio volumio[1674]: info: May 20 16:00:42 volumio volumio[1674]: ---------------------------- MPD announces system playlist update May 20 16:00:42 volumio volumio[1674]: info: Ignoring MPD Status Update May 20 16:00:42 volumio volumio[1674]: info: May 20 16:00:42 volumio volumio[1674]: ---------------------------- MPD announces system playlist update May 20 16:00:42 volumio volumio[1674]: info: Ignoring MPD Status Update May 20 16:00:42 volumio volumio[1674]: info: sendMpdCommand add "USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3" took 1 milliseconds May 20 16:00:42 volumio volumio[1674]: info: ------------------------------ 1ms May 20 16:00:42 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand play May 20 16:00:42 volumio volumio[1674]: info: ------------------------------ 1ms May 20 16:00:42 volumio volumio[1674]: info: sendMpdCommand play took 0 milliseconds May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 20 16:00:42 volumio volumio[1674]: info: Received Get System Info May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:42 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:42 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:42 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 20 16:00:43 volumio volumio[1674]: info: May 20 16:00:43 volumio volumio[1674]: ---------------------------- MPD announces state update: player May 20 16:00:43 volumio volumio[1674]: info: ControllerMpd::getState May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand status May 20 16:00:43 volumio volumio[1674]: info: May 20 16:00:43 volumio volumio[1674]: ---------------------------- MPD announces state update: player May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand clearerror May 20 16:00:43 volumio volumio[1674]: info: sendMpdCommand status took 5 milliseconds May 20 16:00:43 volumio volumio[1674]: info: ControllerMpd::getState May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand status May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::parseState May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 16:00:43 volumio volumio[1674]: info: sendMpdCommand clearerror took 2 milliseconds May 20 16:00:43 volumio volumio[1674]: info: sendMpdCommand status took 2 milliseconds May 20 16:00:43 volumio volumio[1674]: info: sendMpdCommand playlistinfo took 1 milliseconds May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::parseState May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::parseTrackInfo May 20 16:00:43 volumio volumio[1674]: info: ControllerMpd::pushState May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::servicePushState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":164,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dónde Está Mi Gata","artist":"Yandel","album":"Quien Contra Mi","uri":"USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3","trackType":"mp3"} May 20 16:00:43 volumio volumio[1674]: verbose: CURRENT POSITION 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreStateMachine::syncState stateService pause May 20 16:00:43 volumio volumio[1674]: info: CoreStateMachine::syncState currentStatus stop May 20 16:00:43 volumio volumio[1674]: info: CoreStateMachine::pushState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioPushState May 20 16:00:43 volumio volumio[1674]: info: ------------------------------ 16ms May 20 16:00:43 volumio volumio[1674]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 16:00:43 volumio volumio[1674]: verbose: ControllerMpd::parseTrackInfo May 20 16:00:43 volumio volumio[1674]: info: ControllerMpd::pushState May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::servicePushState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":164,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dónde Está Mi Gata","artist":"Yandel","album":"Quien Contra Mi","uri":"USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3","trackType":"mp3"} May 20 16:00:43 volumio volumio[1674]: verbose: CURRENT POSITION 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreStateMachine::syncState stateService pause May 20 16:00:43 volumio volumio[1674]: info: CoreStateMachine::syncState currentStatus stop May 20 16:00:43 volumio volumio[1674]: info: CoreStateMachine::pushState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioPushState May 20 16:00:43 volumio volumio[1674]: info: ------------------------------ 21ms May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:43 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:43 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:44 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:44 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 20 16:00:45 volumio volumio[1674]: info: Received Get System Info May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:45 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:45 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:45 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:45 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:45 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:45 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:45 volumio wpa_supplicant[1153]: wlan0: Failed to initiate sched scan May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:45 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:45 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:45 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:46 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:46 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:46 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:46 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 20 16:00:46 volumio volumio[1674]: info: Received Get System Info May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:00:46 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:46 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:46 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:46 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:46 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:47 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:47 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:48 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:48 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:48 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:48 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:48 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:48 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:48 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:48 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:48 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:48 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:48 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:48 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioPlay May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::play index undefined May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::setConsumeUpdateService undefined May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::startPlaybackTimer May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::clearAddPlayTracks USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3 May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand stop May 20 16:00:49 volumio volumio[1674]: info: May 20 16:00:49 volumio volumio[1674]: ---------------------------- MPD announces state update: player May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand stop took 2 milliseconds May 20 16:00:49 volumio volumio[1674]: info: ControllerMpd::getState May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand status May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand clear May 20 16:00:49 volumio volumio[1674]: info: May 20 16:00:49 volumio volumio[1674]: ---------------------------- MPD announces system playlist update May 20 16:00:49 volumio volumio[1674]: info: Ignoring MPD Status Update May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand status took 1 milliseconds May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand clear took 1 milliseconds May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::parseState May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand add "USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3" May 20 16:00:49 volumio volumio[1674]: error: updateQueue error: null May 20 16:00:49 volumio volumio[1674]: info: May 20 16:00:49 volumio volumio[1674]: ---------------------------- MPD announces system playlist update May 20 16:00:49 volumio volumio[1674]: info: Ignoring MPD Status Update May 20 16:00:49 volumio volumio[1674]: info: ------------------------------ 1ms May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand playlistinfo took 2 milliseconds May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand add "USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3" took 2 milliseconds May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::parseTrackInfo May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand play May 20 16:00:49 volumio volumio[1674]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 20 16:00:49 volumio volumio[1674]: info: ------------------------------ 5ms May 20 16:00:49 volumio volumio[1674]: info: May 20 16:00:49 volumio volumio[1674]: ---------------------------- MPD announces state update: player May 20 16:00:49 volumio volumio[1674]: info: ------------------------------ 2ms May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand play took 1 milliseconds May 20 16:00:49 volumio volumio[1674]: info: ControllerMpd::getState May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand status May 20 16:00:49 volumio volumio[1674]: info: May 20 16:00:49 volumio volumio[1674]: ---------------------------- MPD announces state update: player May 20 16:00:49 volumio volumio[1674]: info: ControllerMpd::getState May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand status May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand clearerror May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand status took 3 milliseconds May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::parseState May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand clearerror May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand status took 6 milliseconds May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand clearerror took 5 milliseconds May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand playlistinfo took 4 milliseconds May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::parseState May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::parseTrackInfo May 20 16:00:49 volumio volumio[1674]: info: ControllerMpd::pushState May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::servicePushState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":164,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dónde Está Mi Gata","artist":"Yandel","album":"Quien Contra Mi","uri":"USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3","trackType":"mp3"} May 20 16:00:49 volumio volumio[1674]: verbose: CURRENT POSITION 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::syncState stateService pause May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::syncState currentStatus stop May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::pushState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioPushState May 20 16:00:49 volumio volumio[1674]: info: ------------------------------ 16ms May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand clearerror took 9 milliseconds May 20 16:00:49 volumio volumio[1674]: info: sendMpdCommand playlistinfo took 9 milliseconds May 20 16:00:49 volumio volumio[1674]: verbose: ControllerMpd::parseTrackInfo May 20 16:00:49 volumio volumio[1674]: info: ControllerMpd::pushState May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::servicePushState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":164,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dónde Está Mi Gata","artist":"Yandel","album":"Quien Contra Mi","uri":"USB/Musica/MUSICA/Reggaeton/Wisin & Yandel/(2003) Yandel Quien Contra Mi/(2003) Yandel Quien Contra Mi/05 Dónde Está Mi Gata.mp3","trackType":"mp3"} May 20 16:00:49 volumio volumio[1674]: verbose: CURRENT POSITION 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::syncState stateService pause May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::syncState currentStatus stop May 20 16:00:49 volumio volumio[1674]: info: CoreStateMachine::pushState May 20 16:00:49 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:49 volumio volumio[1674]: info: CoreCommandRouter::volumioPushState May 20 16:00:49 volumio volumio[1674]: info: ------------------------------ 21ms May 20 16:00:50 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:50 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:50 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:50 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:50 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:50 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:50 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:50 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:50 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:50 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:50 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:50 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:50 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:51 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:51 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:52 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:52 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:52 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:52 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:52 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:52 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:52 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:52 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:52 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:52 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:52 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:52 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:53 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:53 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:53 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:53 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:53 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:53 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:53 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:53 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:53 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:53 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:53 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:53 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:54 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:54 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:55 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:55 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:55 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:55 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:55 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:55 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:55 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:55 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:55 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:55 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:55 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:55 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:55 volumio volumio[1674]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 16:00:56 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:00:56 volumio volumio[1674]: Cannot get aplay -l output: Error: Command failed: /usr/bin/aplay -l May 20 16:00:56 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 20 16:00:56 volumio volumio[1674]: /bin/sh: 1: amixer: not found May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:56 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:56 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:56 volumio wpa_supplicant[1153]: wlan0: Failed to initiate sched scan May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:56 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:56 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:56 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:56 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:56 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:57 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:57 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:57 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:57 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:57 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:57 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:57 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:57 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:57 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:57 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:57 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:57 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:58 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:58 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:59 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:59 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:59 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:59 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:59 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:59 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:59 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:59 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:59 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:59 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:00:59 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:00:59 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 20 16:01:00 volumio volumio[1674]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 20 16:01:00 volumio volumio[1674]: info: Received Get System Version May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 20 16:01:00 volumio volumio[1674]: info: Received Get System Info May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 20 16:01:00 volumio volumio[1674]: info: Discovery: Getting this device information May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:00 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:00 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:01 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:01 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:02 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:02 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:03 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:03 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:04 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:04 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:05 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:05 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:06 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:06 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:07 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Matrix_WiFi7" May 20 16:01:07 volumio wpa_supplicant[1153]: wlan0: Trying to associate with SSID 'Matrix_WiFi7' May 20 16:01:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:07 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 May 20 16:01:07 volumio wpa_supplicant[1153]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Matrix_WiFi7" auth_failures=3 duration=46 reason=CONN_FAILED May 20 16:01:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:07 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:07 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:08 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:08 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:09 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:09 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:10 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:10 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:11 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:11 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:12 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:12 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:13 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:13 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:14 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:14 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:15 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:15 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:16 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:16 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:17 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:17 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:18 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:18 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:19 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:19 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:20 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:20 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:21 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:21 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:22 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:22 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:23 volumio wpa_supplicant[1153]: wlan0: Failed to initiate sched scan May 20 16:01:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:23 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:23 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:24 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:24 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:25 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:25 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:26 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:26 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:27 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:27 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:28 volumio volumio[1674]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 20 16:01:28 volumio volumio[1674]: info: Preparing to save Alsa Options, stopping services first May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::volumioGetState May 20 16:01:28 volumio volumio[1674]: info: CorePlayQueue::getTrack 11075 May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::volumioPause May 20 16:01:28 volumio volumio[1674]: info: CoreStateMachine::pause May 20 16:01:28 volumio volumio[1674]: info: Saving Audio Output to: {"output_device":{"value":"0","label":"IQaudIO DAC"},"i2s":true,"i2sid":{"value":"iqaudio-dacplus","label":"IQaudIO DAC Plus"}} May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:01:28 volumio volumio[1674]: info: Enabling I2S DAC: IQaudIO DAC Plus May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:01:28 volumio sudo[2766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 20 16:01:28 volumio sudo[2766]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:01:28 volumio sudo[2766]: pam_unix(sudo:session): session closed for user root May 20 16:01:28 volumio volumio[1674]: info: No Overlays Loaded May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:01:28 volumio sudo[2769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay iqaudio-dacplus May 20 16:01:28 volumio sudo[2769]: pam_unix(sudo:session): session opened for user root by (uid=0) May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:01:28 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2s@a0000/status May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/status May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/#sound-dai-cells May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/compatible May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/reg May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/AVDD-supply May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/DVDD-supply May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/CPVDD-supply May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /axi/pcie@120000/rp1/i2c@74000/pcm5122@4c/status May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/compatible May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/i2s-controller May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/mute-gpios May 20 16:01:28 volumio kernel: OF: overlay: WARNING: memory leak will occur if overlay removed, property: /soc/sound/status May 20 16:01:28 volumio volumio[1674]: Cannot get aplay -l output: Error: Command failed: /usr/bin/aplay -l May 20 16:01:28 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:01:28 volumio volumio[1674]: warn: Unable to locate the device IQaudIO DAC a reboot may be required. May 20 16:01:28 volumio sudo[2769]: pam_unix(sudo:session): session closed for user root May 20 16:01:28 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:01:28 volumio volumio[1674]: Cannot get aplay -l output: Error: Command failed: /usr/bin/aplay -l May 20 16:01:28 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 20 16:01:28 volumio volumio[1674]: info: Found match in i2s Card Database: setting mixer Digital for card IQaudIO DAC Plus May 20 16:01:28 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:01:28 volumio volumio[1674]: Cannot get aplay -l output: Error: Command failed: /usr/bin/aplay -l May 20 16:01:28 volumio volumio[1674]: /bin/sh: 1: /usr/bin/aplay: not found May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 20 16:01:28 volumio volumio[1674]: info: Updating Volume Controller Parameters: Device: 2 Name: IQaudIO DAC Plus Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 20 16:01:28 volumio volumio[1674]: info: Disabling external Volume Control May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::getUIConfigOnPlugin May 20 16:01:28 volumio volumio[1674]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 20 16:01:28 volumio volumio[1674]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 16:01:28 volumio volumio[1674]: Error: spawn amixer ENOENT May 20 16:01:28 volumio volumio[1674]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) May 20 16:01:28 volumio volumio[1674]: at onErrorNT (internal/child_process.js:465:16) May 20 16:01:28 volumio volumio[1674]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { May 20 16:01:28 volumio volumio[1674]: errno: -2, May 20 16:01:28 volumio volumio[1674]: code: 'ENOENT', May 20 16:01:28 volumio volumio[1674]: syscall: 'spawn amixer', May 20 16:01:28 volumio volumio[1674]: path: 'amixer', May 20 16:01:28 volumio volumio[1674]: spawnargs: [ '-M', 'get', '-c', '2', '"Digital"' ] May 20 16:01:28 volumio volumio[1674]: } May 20 16:01:28 volumio volumio[1674]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 20 16:01:28 volumio sudo[2800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-20 16:00 May 20 16:01:28 volumio sudo[2800]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"