-- Logs begin at Thu 2024-07-11 23:31:05 CST, end at Thu 2024-07-11 23:34:47 CST. -- Jul 11 23:33:07 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:08 vm volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4/35093663-612b-4690-a9f6-d9b7684d6058.jpg' Jul 11 23:33:09 vm volumio[849]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 23:33:09 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:09 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:09 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:09 vm volumio[849]: info: Received Get System Version Jul 11 23:33:09 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 11 23:33:12 vm volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4/35093663-612b-4690-a9f6-d9b7684d6058.jpg' Jul 11 23:33:23 vm volumio[849]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Jul 11 23:33:23 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::Reload Ui Jul 11 23:33:25 vm sudo[1880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 11 23:33:25 vm sudo[1880]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:25 vm sudo[1880]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:25 vm sudo[1882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 11 23:33:25 vm sudo[1882]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:25 vm sudo[1882]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:25 vm volumio[849]: verbose: New Socket.io Connection to 10.2.1.34 from 10.2.1.138 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Edg/126.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 11 23:33:25 vm volumio[849]: info: Received Get System Info Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 23:33:25 vm volumio[849]: info: Discovery: Getting this device information Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:25 vm volumio[849]: info: Listing playlists Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:25 vm volumio[849]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jul 11 23:33:25 vm volumio[849]: info: Received Get System Version Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetQueue Jul 11 23:33:25 vm volumio[849]: info: CoreStateMachine::getQueue Jul 11 23:33:25 vm volumio[849]: info: CorePlayQueue::getQueue Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 11 23:33:25 vm volumio[849]: info: Received Get System Info Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 23:33:25 vm volumio[849]: info: Discovery: Getting this device information Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:25 vm volumio[849]: info: Listing playlists Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 11 23:33:25 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 11 23:33:25 vm volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4/35093663-612b-4690-a9f6-d9b7684d6058.jpg' Jul 11 23:33:26 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 23:33:27 vm volumio[849]: info: Received Get System Info Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 23:33:27 vm volumio[849]: info: Discovery: Getting this device information Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 23:33:27 vm volumio[849]: info: Received Get System Info Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 23:33:27 vm volumio[849]: info: Discovery: Getting this device information Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:27 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 23:33:30 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:33 vm volumio[849]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4/35093663-612b-4690-a9f6-d9b7684d6058.jpg' Jul 11 23:33:35 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 11 23:33:35 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 11 23:33:36 vm volumio[849]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 23:33:36 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:36 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:36 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 11 23:33:36 vm volumio[849]: info: Received Get System Version Jul 11 23:33:36 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 11 23:33:45 vm volumio[849]: info: CALLMETHOD: system_controller system saveHDMISettings [object Object] Jul 11 23:33:45 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , saveHDMISettings Jul 11 23:33:45 vm sudo[1906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Jul 11 23:33:45 vm sudo[1906]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:45 vm startx[851]: xinit: connection to X server lost Jul 11 23:33:45 vm startx[851]: [1B blob data] Jul 11 23:33:45 vm systemd[1]: Stopping Start Volumio Kiosk... Jul 11 23:33:45 vm startx[851]: waiting for X server to shut down (II) Server terminated successfully (0). Closing log file. Jul 11 23:33:46 vm startx[851]: xinit: unexpected signal 15 Jul 11 23:33:46 vm systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Jul 11 23:33:46 vm systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Jul 11 23:33:46 vm systemd[1]: Stopped Start Volumio Kiosk. Jul 11 23:33:46 vm sudo[1906]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:46 vm sudo[1913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable volumio-kiosk.service Jul 11 23:33:46 vm sudo[1913]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:46 vm systemd[1]: Reloading. Jul 11 23:33:46 vm systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 11 23:33:46 vm systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jul 11 23:33:46 vm sudo[1913]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:46 vm volumio[849]: info: disable volumio-kiosk service success Jul 11 23:33:48 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:33:50 vm volumio[849]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 23:33:50 vm volumio[849]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Jul 11 23:33:50 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 11 23:33:50 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jul 11 23:33:50 vm sudo[1932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jul 11 23:33:50 vm sudo[1932]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1932]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm sudo[1937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 11 23:33:50 vm sudo[1937]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 11 23:33:50 vm sudo[1945]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jul 11 23:33:50 vm sudo[1951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1937]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm sudo[1960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 11 23:33:50 vm sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 11 23:33:50 vm sudo[1967]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1951]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm sudo[1945]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm sudo[1967]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm sudo[1960]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jul 11 23:33:50 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jul 11 23:33:50 vm sudo[1978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jul 11 23:33:50 vm sudo[1978]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1978]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm volumio[849]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Jul 11 23:33:50 vm volumio[849]: wlan0 Interface doesn't support scanning. Jul 11 23:33:50 vm volumio[849]: info: Cannot use regular scanning, forcing with ap-force Jul 11 23:33:50 vm sudo[1983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Jul 11 23:33:50 vm sudo[1983]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:33:50 vm sudo[1983]: pam_unix(sudo:session): session closed for user root Jul 11 23:33:50 vm volumio[849]: command failed: No such device (-19) Jul 11 23:33:50 vm volumio[849]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Jul 11 23:33:50 vm volumio[849]: command failed: No such device (-19) Jul 11 23:33:55 vm volumio[849]: info: CoreCommandRouter::volumioGetState Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 11 23:34:01 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:31 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:31 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::servicePushState Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:33 vm shairport-sync[1693]: {"time":1720711951785,"response":"startAirplayPlayback Success"} % Total % Received % Xferd Average Speed Time Time Time Current Jul 11 23:34:33 vm shairport-sync[1693]: Dload Upload Total Spent Left Speed Jul 11 23:34:33 vm volumio[849]: info: Jul 11 23:34:33 vm volumio[849]: ---------------------------- Client requests Stop Airplay Playback Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , stopAirplayPlayback Jul 11 23:34:33 vm volumio[849]: info: Airplay playback stop Jul 11 23:34:33 vm volumio[849]: info: Airplay Playback Stopped, clearing state Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::resetVolumioState Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::getcurrentVolume Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioRetrievevolume Jul 11 23:34:33 vm shairport-sync[1693]: [158B blob data] Jul 11 23:34:33 vm volumio[849]: info: VolumeController:: Volume=19 Mute =false Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::updateTrackBlock Jul 11 23:34:33 vm volumio[849]: info: CorePlayQueue::getTrackBlock Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioRetrievevolume Jul 11 23:34:33 vm volumio[849]: info: VolumeController:: Volume=19 Mute =false Jul 11 23:34:33 vm volumio[849]: info: CoreStateMachine::pushState Jul 11 23:34:33 vm volumio[849]: info: CoreCommandRouter::volumioPushState Jul 11 23:34:34 vm volumio[849]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jul 11 23:34:34 vm sudo[2040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 11 23:34:34 vm sudo[2040]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm sudo[2040]: pam_unix(sudo:session): session closed for user root Jul 11 23:34:34 vm sudo[2042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 11 23:34:34 vm sudo[2042]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 11 23:34:34 vm systemd[1]: Stopping Music Player Daemon... Jul 11 23:34:34 vm systemd[1]: mpd.service: Succeeded. Jul 11 23:34:34 vm systemd[1]: Stopped Music Player Daemon. Jul 11 23:34:34 vm volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 11 23:34:34 vm volumio[849]: info: MPD Permissions set Jul 11 23:34:34 vm systemd[1]: Starting Music Player Daemon... Jul 11 23:34:34 vm sudo[2051]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 11 23:34:34 vm sudo[2051]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 23:34:34 vm sudo[2051]: pam_unix(sudo:session): session closed for user root Jul 11 23:34:34 vm mpd[2053]: Jul 11 23:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 11 23:34:34 vm systemd[1]: Started Music Player Daemon. Jul 11 23:34:34 vm sudo[2042]: pam_unix(sudo:session): session closed for user root Jul 11 23:34:34 vm volumio[849]: error: updateQueue error: null Jul 11 23:34:47 vm volumio[849]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 23:34:47 vm volumio[849]: Error: connect ETIMEDOUT 65.49.26.97:443 Jul 11 23:34:47 vm volumio[849]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 11 23:34:47 vm volumio[849]: errno: -110, Jul 11 23:34:47 vm volumio[849]: code: 'ETIMEDOUT', Jul 11 23:34:47 vm volumio[849]: syscall: 'connect', Jul 11 23:34:47 vm volumio[849]: address: '65.49.26.97', Jul 11 23:34:47 vm volumio[849]: port: 443 Jul 11 23:34:47 vm volumio[849]: } Jul 11 23:34:47 vm volumio[849]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 23:34:47 vm sudo[2066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-11 23:33 Jul 11 23:34:47 vm sudo[2066]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"