-- Logs begin at Mon 2025-03-10 19:50:46 EET, end at Mon 2025-03-10 19:52:17 EET. -- Mar 10 19:51:00 volumio systemd[1]: Starting Time & Date Service... Mar 10 19:51:00 volumio sudo[1507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 10 19:51:00 volumio sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:00 volumio sudo[1507]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:00 volumio volumio[958]: No state is present for card NVidia Mar 10 19:51:00 volumio volumio[958]: Found hardware: "HDA-Intel" "Nvidia GPU 0b HDMI/DP" "HDA:10de000b,10de0101,00100200" "0x1458" "0x34ef" Mar 10 19:51:00 volumio volumio[958]: Hardware is initialized using a generic method Mar 10 19:51:00 volumio volumio[958]: No state is present for card NVidia Mar 10 19:51:00 volumio volumio[958]: No state is present for card AUDIO Mar 10 19:51:00 volumio volumio[958]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:3086" "" "" Mar 10 19:51:00 volumio volumio[958]: Hardware is initialized using a generic method Mar 10 19:51:00 volumio volumio[958]: No state is present for card AUDIO Mar 10 19:51:00 volumio volumio[958]: info: Output device has changed, restarting MPD Mar 10 19:51:00 volumio dbus-daemon[720]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 10 19:51:00 volumio systemd[1]: Started Time & Date Service. Mar 10 19:51:00 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 19:51:00 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:00 volumio volumio[958]: info: Output device has changed, restarting Shairport Sync Mar 10 19:51:00 volumio volumio[958]: error: MPD error: The expression evaluated to a falsy value: Mar 10 19:51:00 volumio volumio[958]: assert.ok(self.idling) Mar 10 19:51:00 volumio volumio[958]: error: The expression evaluated to a falsy value: Mar 10 19:51:00 volumio volumio[958]: assert.ok(self.idling) Mar 10 19:51:00 volumio volumio[958]: error: MPD error: The expression evaluated to a falsy value: Mar 10 19:51:00 volumio volumio[958]: assert.ok(self.idling) Mar 10 19:51:00 volumio volumio[958]: error: The expression evaluated to a falsy value: Mar 10 19:51:00 volumio volumio[958]: assert.ok(self.idling) Mar 10 19:51:00 volumio volumio[958]: error: updateQueue error: null Mar 10 19:51:00 volumio sudo[1606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Mar 10 19:51:00 volumio sudo[1606]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:00 volumio sudo[1606]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:00 volumio volumio[958]: info: Permissions for /etc/hostapd/hostapd.conf Mar 10 19:51:00 volumio nmbd[888]: [2025/03/10 17:51:00.106074, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 10 19:51:00 volumio nmbd[888]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 10 19:51:00 volumio systemd[1]: Started Samba NMB Daemon. Mar 10 19:51:00 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Mar 10 19:51:00 volumio volumio[958]: info: Discovery: Restarting Advertising due to device name change Mar 10 19:51:00 volumio sudo[1610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Mar 10 19:51:00 volumio sudo[1610]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:00 volumio systemd[1]: Starting Samba Winbind Daemon... Mar 10 19:51:00 volumio systemd[1]: Starting Wireless Services... Mar 10 19:51:00 volumio winbindd[1609]: [2025/03/10 17:51:00.339169, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 10 19:51:00 volumio winbindd[1609]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 10 19:51:00 volumio winbindd[1609]: [2025/03/10 17:51:00.357447, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 10 19:51:00 volumio winbindd[1609]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 10 19:51:00 volumio systemd[1]: Started Samba Winbind Daemon. Mar 10 19:51:00 volumio wireless.js[1613]: WIRELESS: No wireless interface, exiting Mar 10 19:51:00 volumio systemd[1]: Starting Samba SMB Daemon... Mar 10 19:51:00 volumio iw[1627]: command failed: No such device (-19) Mar 10 19:51:00 volumio iwconfig[1631]: Error for wireless request "Set Power Management" (8B2C) : Mar 10 19:51:00 volumio iwconfig[1631]: SET failed on device wlan0 ; No such device. Mar 10 19:51:00 volumio systemd[1]: wireless.service: Succeeded. Mar 10 19:51:00 volumio systemd[1]: Started Wireless Services. Mar 10 19:51:00 volumio sudo[1610]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:00 volumio ntpd[1454]: Soliciting pool server 91.231.182.17 Mar 10 19:51:00 volumio ntpd[1454]: Soliciting pool server 91.236.251.29 Mar 10 19:51:00 volumio ntpd[1454]: Soliciting pool server 193.106.144.6 Mar 10 19:51:00 volumio volumio[958]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 10 19:51:00 volumio volumio[958]: info: CoreStateMachine::getcurrentVolume Mar 10 19:51:00 volumio volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:51:00 volumio volumio[958]: Unable to parse: Mar 10 19:51:00 volumio volumio[958]: Simple mixer control 'IEC958',0 Mar 10 19:51:00 volumio volumio[958]: Capabilities: pswitch pswitch-joined Mar 10 19:51:00 volumio volumio[958]: Playback channels: Mono Mar 10 19:51:00 volumio volumio[958]: Mono: Playback [off] Mar 10 19:51:00 volumio volumio[958]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 10 19:51:00 volumio smbd[1629]: [2025/03/10 17:51:00.814893, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 10 19:51:00 volumio smbd[1629]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 10 19:51:00 volumio systemd[1]: Started Samba SMB Daemon. Mar 10 19:51:00 volumio systemd[1]: Reached target Multi-User System. Mar 10 19:51:00 volumio systemd[1]: Reached target Graphical Interface. Mar 10 19:51:00 volumio volumio[958]: Unable to parse: Mar 10 19:51:00 volumio volumio[958]: Simple mixer control 'IEC958',0 Mar 10 19:51:00 volumio volumio[958]: Capabilities: pswitch pswitch-joined Mar 10 19:51:00 volumio volumio[958]: Playback channels: Mono Mar 10 19:51:00 volumio volumio[958]: Mono: Playback [off] Mar 10 19:51:00 volumio volumio[958]: info: VolumeController:: Volume=undefined Mute =false Mar 10 19:51:00 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:00 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:00 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:00 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 10 19:51:00 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 10 19:51:00 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 10 19:51:00 volumio volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:51:00 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 10 19:51:00 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 10 19:51:00 volumio systemd[1]: Startup finished in 12.940s (kernel) + 16.365s (userspace) = 29.305s. Mar 10 19:51:00 volumio volumio[958]: Unable to parse: Mar 10 19:51:00 volumio volumio[958]: Simple mixer control 'IEC958',0 Mar 10 19:51:00 volumio volumio[958]: Capabilities: pswitch pswitch-joined Mar 10 19:51:00 volumio volumio[958]: Playback channels: Mono Mar 10 19:51:00 volumio volumio[958]: Mono: Playback [off] Mar 10 19:51:00 volumio volumio[958]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Mar 10 19:51:00 volumio volumio[958]: Unable to parse: Mar 10 19:51:00 volumio volumio[958]: Simple mixer control 'IEC958',0 Mar 10 19:51:00 volumio volumio[958]: Capabilities: pswitch pswitch-joined Mar 10 19:51:00 volumio volumio[958]: Playback channels: Mono Mar 10 19:51:00 volumio volumio[958]: Mono: Playback [off] Mar 10 19:51:00 volumio volumio[958]: info: VolumeController:: Volume=undefined Mute =false Mar 10 19:51:00 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:00 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:00 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:01 volumio volumio[958]: info: Discovery: A device disappeared from network Mar 10 19:51:01 volumio volumio[958]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Mar 10 19:51:01 volumio ntpd[1454]: Soliciting pool server 109.110.82.19 Mar 10 19:51:01 volumio ntpd[1454]: Soliciting pool server 194.8.146.38 Mar 10 19:51:01 volumio ntpd[1454]: Soliciting pool server 162.159.200.123 Mar 10 19:51:01 volumio ntpd[1454]: Soliciting pool server 62.205.159.153 Mar 10 19:51:02 volumio ntpd[1454]: Soliciting pool server 46.173.175.211 Mar 10 19:51:02 volumio ntpd[1454]: Soliciting pool server 130.255.135.221 Mar 10 19:51:03 volumio ntpd[1454]: Soliciting pool server 162.159.200.1 Mar 10 19:51:04 volumio ntpd[1454]: Soliciting pool server 193.192.36.120 Mar 10 19:51:05 volumio volumio[958]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 10 19:51:05 volumio volumio[958]: info: Discovery: Started advertising with name: Volumio Mar 10 19:51:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Mar 10 19:51:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Mar 10 19:51:05 volumio sudo[1648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:05 volumio sudo[1648]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:05 volumio sudo[1648]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:06 volumio ntpd[1454]: receive: Unexpected origin timestamp 0xeb79a509.c4dafb82 does not match aorg 0000000000.00000000 from server@91.231.182.17 xmt 0xeb79a50a.b159ea46 Mar 10 19:51:06 volumio ntpd[1454]: receive: Unexpected origin timestamp 0xeb79a509.c4d984d6 does not match aorg 0000000000.00000000 from server@91.236.251.29 xmt 0xeb79a50a.b21f4a4b Mar 10 19:51:06 volumio ntpd[1454]: receive: Unexpected origin timestamp 0xeb79a509.c4d34ed6 does not match aorg 0000000000.00000000 from server@46.173.175.211 xmt 0xeb79a50a.b412dfd6 Mar 10 19:51:06 volumio ntpd[1454]: receive: Unexpected origin timestamp 0xeb79a509.c4d6051b does not match aorg 0000000000.00000000 from server@194.8.146.38 xmt 0xeb79a50a.b2ebd4cf Mar 10 19:51:06 volumio volumio[958]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 10 19:51:07 volumio volumio-remote-updater[708]: [2025-03-10 17:51:07] [connect] Successful connection Mar 10 19:51:07 volumio volumio-remote-updater[708]: [2025-03-10 17:51:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741629067 101 Mar 10 19:51:07 volumio volumio[958]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 2 Mar 10 19:51:07 volumio sudo[1654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:51:07 volumio sudo[1654]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:07 volumio sudo[1654]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:07 volumio sudo[1656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:07 volumio sudo[1656]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:07 volumio sudo[1656]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:07 volumio volumio[958]: verbose: New Socket.io Connection to 192.168.0.119 from 192.168.0.103 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 OPR/117.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 10 19:51:07 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:07 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:07 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:07 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:07 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:07 volumio volumio[958]: info: Volumio Network Manager: Network status updated: 1 Mar 10 19:51:07 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:07 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:07 volumio sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:51:07 volumio sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:07 volumio sudo[1677]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:07 volumio sudo[1679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:07 volumio sudo[1679]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:07 volumio sudo[1679]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:07 volumio sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 10 19:51:07 volumio sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:07 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 10 19:51:07 volumio sudo[1685]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:07 volumio volumio[958]: info: Upmpdcli Daemon Started Mar 10 19:51:08 volumio volumio[1687]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 10 19:51:08 volumio volumio[1687]: ............++++ Mar 10 19:51:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 10 19:51:08 volumio volumio[958]: info: Loading i18n strings for locale ru Mar 10 19:51:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 10 19:51:08 volumio volumio[958]: info: Setting timezone to Europe/Kiev Mar 10 19:51:08 volumio sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 10 19:51:08 volumio sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:08 volumio sudo[1704]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:08 volumio sudo[1707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kiev /etc/localtime Mar 10 19:51:08 volumio sudo[1707]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:08 volumio sudo[1707]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:08 volumio sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 10 19:51:08 volumio sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:08 volumio sudo[1710]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:08 volumio sudo[1713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kiev Mar 10 19:51:08 volumio sudo[1713]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:08 volumio systemd-timedated[1505]: Failed to set time zone: Permission denied Mar 10 19:51:08 volumio sudo[1713]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:08 volumio volumio[1687]: ....................++++ Mar 10 19:51:08 volumio volumio[958]: Failed to set time zone: Access denied Mar 10 19:51:08 volumio volumio[1687]: e is 65537 (0x010001) Mar 10 19:51:08 volumio volumio[958]: info: Could not set timezone, retrying Mar 10 19:51:08 volumio volumio[1687]: writing RSA key Mar 10 19:51:08 volumio volumio[958]: Updating browse sources language Mar 10 19:51:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 10 19:51:09 volumio volumio[958]: info: Adding plugin bluetooth to MyMusic Plugins Mar 10 19:51:09 volumio volumio[958]: info: Adding plugin multiroom to MyMusic Plugins Mar 10 19:51:09 volumio volumio[958]: info: Adding plugin metavolumio to MyMusic Plugins Mar 10 19:51:09 volumio volumio[958]: info: Adding plugin cd_controller to MyMusic Plugins Mar 10 19:51:09 volumio volumio[958]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 10 19:51:09 volumio volumio[958]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 10 19:51:09 volumio volumio[958]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 10 19:51:10 volumio volumio[958]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 10 19:51:10 volumio volumio[958]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 10 19:51:10 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:10 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:10 volumio volumio[958]: info: Starting MyVolumio Remote Streaming Endpoints Mar 10 19:51:10 volumio volumio[958]: info: MyVolumio not started Mar 10 19:51:10 volumio volumio[958]: info: Initializing device activation check Mar 10 19:51:10 volumio volumio[958]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 10 19:51:10 volumio volumio[958]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 10 19:51:13 volumio volumio[958]: info: Starting Streaming Service Transparent Proxy Mar 10 19:51:13 volumio volumio[958]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 10 19:51:13 volumio volumio[958]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 10 19:51:13 volumio volumio[958]: info: Streaming services startup Mar 10 19:51:13 volumio volumio[958]: info: Starting Streaming Daemon Mar 10 19:51:13 volumio sudo[1766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 10 19:51:13 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio volumio[958]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 10 19:51:13 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio sudo[1774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kiev Mar 10 19:51:13 volumio sudo[1774]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1774]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Mar 10 19:51:13 volumio volumio[958]: info: Refreshing Cached IP Addresses Mar 10 19:51:13 volumio sudo[1777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Mar 10 19:51:13 volumio sudo[1777]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:51:13 volumio sudo[1779]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1779]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 10 19:51:13 volumio volumio[958]: info: Loading i18n strings for locale ru Mar 10 19:51:13 volumio sudo[1777]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio sudo[1783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:13 volumio sudo[1783]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1783]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 10 19:51:13 volumio volumio[958]: info: Setting timezone to Europe/Kiev Mar 10 19:51:13 volumio sudo[1788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 10 19:51:13 volumio sudo[1788]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1788]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio sudo[1791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kiev /etc/localtime Mar 10 19:51:13 volumio sudo[1791]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1791]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio sudo[1794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 10 19:51:13 volumio sudo[1794]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1794]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio sudo[1797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kiev Mar 10 19:51:13 volumio sudo[1797]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1797]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 10 19:51:13 volumio sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 10 19:51:13 volumio sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio volumio[958]: error: Cannot start Volumio Streaming Daemon Mar 10 19:51:13 volumio volumio[958]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 10 19:51:13 volumio volumio[958]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 10 19:51:13 volumio sudo[1800]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio volumio[958]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 10 19:51:13 volumio volumio[958]: wlan0 Interface doesn't support scanning. Mar 10 19:51:13 volumio volumio[958]: info: Cannot use regular scanning, forcing with ap-force Mar 10 19:51:13 volumio sudo[1805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 10 19:51:13 volumio sudo[1805]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:13 volumio sudo[1805]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:13 volumio volumio[958]: command failed: No such device (-19) Mar 10 19:51:13 volumio volumio[958]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 10 19:51:13 volumio volumio[958]: command failed: No such device (-19) Mar 10 19:51:13 volumio volumio[958]: STREAMING PROXY: Starting server on port 3245 Mar 10 19:51:13 volumio volumio[958]: Node JS runtime: 14 Mar 10 19:51:13 volumio systemd[1]: upmpdcli.service: Succeeded. Mar 10 19:51:13 volumio volumio[958]: Updating browse sources language Mar 10 19:51:13 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:13 volumio volumio[958]: info: Fetching Streaming Services browse cache Mar 10 19:51:14 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 10 19:51:14 volumio volumio[958]: info: MyVolumio login type: Token Mar 10 19:51:14 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 10 19:51:14 volumio volumio[958]: info: MyVolumio login type: Token Mar 10 19:51:14 volumio volumio[958]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 10 19:51:15 volumio volumio[958]: info: MyVolumio token set successfully Mar 10 19:51:15 volumio volumio[958]: info: MYVOLUMIO: Adding device Mar 10 19:51:15 volumio volumio[958]: info: MYVOLUMIO: Evaluating Server Mar 10 19:51:16 volumio volumio[958]: info: MyVolumio status changed Mar 10 19:51:16 volumio volumio[958]: info: Streaming services startup Mar 10 19:51:16 volumio volumio[958]: info: Starting Streaming Daemon Mar 10 19:51:16 volumio volumio[958]: info: Removing browser output: myVolumio user plan is not superstar Mar 10 19:51:16 volumio volumio[958]: info: Removing audio output: Mar 10 19:51:16 volumio volumio[958]: info: Stoppping Tunnel 1 Mar 10 19:51:16 volumio sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 10 19:51:16 volumio sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:16 volumio sudo[1841]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:16 volumio sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 10 19:51:16 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:16 volumio volumio[958]: error: Cannot start Volumio Streaming Daemon Mar 10 19:51:16 volumio volumio[958]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 10 19:51:16 volumio volumio[958]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 10 19:51:16 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:16 volumio volumio[958]: info: Remote SSH Stopped Mar 10 19:51:16 volumio volumio[958]: info: Setting Geolocation for MyVolumio to eu10 Mar 10 19:51:16 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:16 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:16 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:16 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:16 volumio volumio[958]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 10 19:51:17 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:17 volumio volumio[958]: info: Updating MyVolumio device info Mar 10 19:51:17 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:17 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:17 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:17 volumio volumio[958]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 10 19:51:18 volumio dbus-daemon[720]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.18' (uid=0 pid=1744 comm="/usr/lib/chromium/chromium --show-component-extens") Mar 10 19:51:18 volumio systemd[1]: Starting Bluetooth service... Mar 10 19:51:18 volumio systemd[1]: systemd-fsckd.service: Succeeded. Mar 10 19:51:18 volumio kernel: Bluetooth: Core ver 2.22 Mar 10 19:51:18 volumio kernel: NET: Registered PF_BLUETOOTH protocol family Mar 10 19:51:18 volumio kernel: Bluetooth: HCI device and connection manager initialized Mar 10 19:51:18 volumio kernel: Bluetooth: HCI socket layer initialized Mar 10 19:51:18 volumio kernel: Bluetooth: L2CAP socket layer initialized Mar 10 19:51:18 volumio kernel: Bluetooth: SCO socket layer initialized Mar 10 19:51:18 volumio bluetoothd[1869]: Bluetooth daemon 5.50 Mar 10 19:51:18 volumio bluetoothd[1869]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 10 19:51:18 volumio dbus-daemon[720]: [system] Successfully activated service 'org.bluez' Mar 10 19:51:18 volumio systemd[1]: Started Bluetooth service. Mar 10 19:51:18 volumio bluetoothd[1869]: Starting SDP server Mar 10 19:51:18 volumio bluetoothd[1869]: Excluding (cli) sap Mar 10 19:51:18 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 10 19:51:18 volumio kernel: Bluetooth: BNEP filters: protocol multicast Mar 10 19:51:18 volumio kernel: Bluetooth: BNEP socket layer initialized Mar 10 19:51:18 volumio dbus-daemon[720]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.19' (uid=0 pid=1869 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Mar 10 19:51:18 volumio bluetoothd[1869]: Bluetooth management interface 1.22 initialized Mar 10 19:51:18 volumio systemd[1]: Starting Hostname Service... Mar 10 19:51:19 volumio dbus-daemon[720]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 10 19:51:19 volumio systemd[1]: Started Hostname Service. Mar 10 19:51:20 volumio volumio[958]: 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: 4 Mar 10 19:51:20 volumio volumio[958]: info: MYVOLUMIO: Adding device Mar 10 19:51:20 volumio volumio[958]: info: MYVOLUMIO: Evaluating Server Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 10 19:51:21 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:21 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:21 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:21 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:21 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:21 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:21 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:21 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:21 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:21 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:21 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:21 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:21 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:21 volumio volumio[958]: info: Got it Mar 10 19:51:21 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:21 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:21 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:21 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:22 volumio volumio[958]: info: Setting Geolocation for MyVolumio to eu10 Mar 10 19:51:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:22 volumio volumio[958]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 10 19:51:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 10 19:51:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 10 19:51:22 volumio volumio[958]: info: Loading i18n strings for locale en Mar 10 19:51:22 volumio volumio[958]: Updating browse sources language Mar 10 19:51:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:22 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 10 19:51:22 volumio volumio[958]: info: Setting timezone to Europe/Kiev Mar 10 19:51:22 volumio sudo[2010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 10 19:51:22 volumio sudo[2010]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:22 volumio sudo[2010]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:22 volumio sudo[2013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kiev /etc/localtime Mar 10 19:51:22 volumio sudo[2013]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:22 volumio sudo[2013]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:22 volumio sudo[2016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 10 19:51:22 volumio sudo[2016]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:22 volumio sudo[2016]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:22 volumio sudo[2019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kiev Mar 10 19:51:22 volumio sudo[2019]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:22 volumio sudo[2019]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:23 volumio volumio[958]: info: Updating MyVolumio device info Mar 10 19:51:23 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:23 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:23 volumio volumio[958]: info: Fetching Streaming Services browse cache Mar 10 19:51:23 volumio volumio[958]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 10 19:51:23 volumio sudo[2022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:51:23 volumio sudo[2022]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:23 volumio sudo[2022]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:23 volumio sudo[2025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:23 volumio sudo[2025]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:23 volumio sudo[2025]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:23 volumio sudo[2029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 10 19:51:23 volumio sudo[2029]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:23 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Mar 10 19:51:23 volumio sudo[2029]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:23 volumio volumio[958]: info: Upmpdcli Daemon Started Mar 10 19:51:23 volumio volumio[2032]: writing RSA key Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:25 volumio volumio[958]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:25 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:25 volumio volumio[958]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 10 19:51:25 volumio volumio[958]: info: Received Get System Version Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:51:25 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:25 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:25 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 10 19:51:25 volumio volumio[958]: info: Preparing to save Alsa Options, stopping services first Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:25 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::volumioPause Mar 10 19:51:25 volumio volumio[958]: info: CoreStateMachine::pause Mar 10 19:51:25 volumio volumio[958]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"XMOS USB AUDIO"},"disallowPush":true} Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:25 volumio volumio[958]: info: Setting mixer XMOS USB AUDIO for card XMOS USB AUDIO Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 10 19:51:25 volumio volumio[958]: info: Updating Volume Controller Parameters: Device: 5 Name: XMOS USB AUDIO Mixer: XMOS USB AUDIO Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 10 19:51:25 volumio volumio[958]: info: Disabling external Volume Control Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:25 volumio volumio[958]: info: Preparing to generate the ALSA configuration file Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:25 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:25 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:25 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:25 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:25 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:25 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:25 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:25 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:25 volumio volumio[958]: info: Got it Mar 10 19:51:25 volumio volumio[958]: info: Got it Mar 10 19:51:25 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 10 19:51:25 volumio volumio[958]: info: VolumeController:: Volume=100 Mute =false Mar 10 19:51:25 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:25 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:25 volumio volumio[958]: info: Asound.conf file written Mar 10 19:51:25 volumio sudo[2085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 10 19:51:25 volumio sudo[2085]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:25 volumio sudo[2085]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:25 volumio volumio[958]: No state is present for card NVidia Mar 10 19:51:25 volumio volumio[958]: Found hardware: "HDA-Intel" "Nvidia GPU 0b HDMI/DP" "HDA:10de000b,10de0101,00100200" "0x1458" "0x34ef" Mar 10 19:51:25 volumio volumio[958]: Hardware is initialized using a generic method Mar 10 19:51:25 volumio volumio[958]: No state is present for card NVidia Mar 10 19:51:25 volumio volumio[958]: No state is present for card AUDIO Mar 10 19:51:25 volumio volumio[958]: Found hardware: "USB-Audio" "USB Mixer" "USB20b1:3086" "" "" Mar 10 19:51:25 volumio volumio[958]: Hardware is initialized using a generic method Mar 10 19:51:25 volumio volumio[958]: No state is present for card AUDIO Mar 10 19:51:25 volumio volumio[958]: info: Output device has changed, restarting MPD Mar 10 19:51:25 volumio sudo[2090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 19:51:25 volumio sudo[2090]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:25 volumio volumio[958]: info: Output device has changed, restarting Shairport Sync Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:25 volumio sudo[2090]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:25 volumio sudo[2093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 19:51:25 volumio sudo[2093]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:25 volumio systemd[1]: Stopping Music Player Daemon... Mar 10 19:51:25 volumio volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 19:51:25 volumio volumio[958]: info: Output device has changed, restarting MPD Mar 10 19:51:25 volumio systemd[1]: mpd.service: Succeeded. Mar 10 19:51:25 volumio systemd[1]: Stopped Music Player Daemon. Mar 10 19:51:25 volumio sudo[2100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 19:51:25 volumio volumio[958]: info: Output device has changed, restarting Shairport Sync Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:25 volumio systemd[1]: Starting Music Player Daemon... Mar 10 19:51:25 volumio sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:25 volumio sudo[2100]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:25 volumio sudo[2103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 19:51:25 volumio sudo[2103]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:26 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 10 19:51:26 volumio systemd[1]: mpd.service: Succeeded. Mar 10 19:51:26 volumio systemd[1]: Stopped Music Player Daemon. Mar 10 19:51:26 volumio systemd[1]: Starting Music Player Daemon... Mar 10 19:51:26 volumio volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:26 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:26 volumio volumio[958]: info: MPD Permissions set Mar 10 19:51:26 volumio volumio[958]: info: MPD Permissions set Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio sudo[2108]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 10 19:51:26 volumio sudo[2108]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:26 volumio sudo[2108]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 10 19:51:26 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:26 volumio volumio[958]: info: Starting Shairport Sync Mar 10 19:51:26 volumio volumio[958]: info: Starting Shairport Sync Mar 10 19:51:26 volumio sudo[2124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 19:51:26 volumio sudo[2124]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:26 volumio sudo[2127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 19:51:26 volumio sudo[2127]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 19:51:26 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 19:51:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 19:51:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 19:51:26 volumio sudo[2124]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:26 volumio volumio[958]: info: Shairport-Sync Started Mar 10 19:51:26 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 19:51:26 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 10 19:51:26 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 19:51:26 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 19:51:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 19:51:26 volumio sudo[2127]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:26 volumio volumio[958]: info: Shairport-Sync Started Mar 10 19:51:26 volumio mpd[2117]: Mar 10 19:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 10 19:51:26 volumio systemd[1]: Started Music Player Daemon. Mar 10 19:51:26 volumio sudo[2103]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:26 volumio sudo[2093]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:26 volumio volumio[958]: error: MPD error: The expression evaluated to a falsy value: Mar 10 19:51:26 volumio volumio[958]: assert.ok(self.idling) Mar 10 19:51:26 volumio volumio[958]: error: The expression evaluated to a falsy value: Mar 10 19:51:26 volumio volumio[958]: assert.ok(self.idling) Mar 10 19:51:26 volumio volumio[958]: error: updateQueue error: null Mar 10 19:51:28 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Mar 10 19:51:28 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 10 19:51:28 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Mar 10 19:51:28 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Mar 10 19:51:28 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 10 19:51:29 volumio volumio[958]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 10 19:51:29 volumio volumio[958]: info: CoreStateMachine::getcurrentVolume Mar 10 19:51:29 volumio volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:51:29 volumio volumio[958]: info: VolumeController:: Volume=100 Mute =false Mar 10 19:51:29 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:29 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:29 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:29 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 10 19:51:29 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 10 19:51:29 volumio volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:51:29 volumio volumio[958]: info: VolumeController:: Volume=100 Mute =false Mar 10 19:51:29 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:29 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:29 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:51:30 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:30 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:51:30 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:30 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:33 volumio volumio[958]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 10 19:51:33 volumio volumio[958]: info: Completed starting MyVolumio Plugin Mar 10 19:51:33 volumio volumio[958]: [Metrics] CommandRouter: 38s 119.67ms Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::volumiosetStartupVolume Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::Close All Modals sent Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::Close All Modals sent Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:33 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:33 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:33 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:33 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:33 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:33 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:33 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:33 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: info: Got it Mar 10 19:51:33 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:33 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:33 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 10 19:51:34 volumio volumio[958]: info: Version has changed, forcing UI Reload Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::Reload Ui Mar 10 19:51:34 volumio sudo[2341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:51:34 volumio sudo[2341]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:34 volumio sudo[2341]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:34 volumio sudo[2344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:34 volumio sudo[2344]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:34 volumio sudo[2344]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:34 volumio volumio[958]: verbose: New Socket.io Connection to 192.168.0.119 from 192.168.0.103 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 OPR/117.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 10 19:51:34 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:34 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:34 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:34 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:34 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:34 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:34 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:34 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:34 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:34 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:34 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:34 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:34 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:34 volumio volumio[958]: info: Got it Mar 10 19:51:34 volumio volumio[958]: info: Got it Mar 10 19:51:34 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:34 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:34 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:34 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:34 volumio volumio[958]: 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 Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 10 19:51:35 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:35 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:35 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:35 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:35 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:35 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:35 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:35 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:35 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:35 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:35 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:35 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:35 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:35 volumio volumio[958]: info: Got it Mar 10 19:51:35 volumio volumio[958]: info: Got it Mar 10 19:51:35 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:35 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:35 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 10 19:51:35 volumio volumio[958]: info: Loading i18n strings for locale ru Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 10 19:51:35 volumio volumio[958]: info: Setting timezone to Europe/Kiev Mar 10 19:51:35 volumio sudo[2357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 10 19:51:35 volumio sudo[2357]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:35 volumio sudo[2357]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:35 volumio sudo[2360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kiev /etc/localtime Mar 10 19:51:35 volumio sudo[2360]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:35 volumio sudo[2360]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:35 volumio sudo[2363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 10 19:51:35 volumio sudo[2363]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:35 volumio sudo[2363]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:35 volumio sudo[2366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kiev Mar 10 19:51:35 volumio sudo[2366]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:35 volumio sudo[2366]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:35 volumio volumio[958]: Updating browse sources language Mar 10 19:51:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:36 volumio volumio[958]: info: Fetching Streaming Services browse cache Mar 10 19:51:36 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:36 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 10 19:51:36 volumio volumio[958]: info: Loading i18n strings for locale en Mar 10 19:51:36 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 10 19:51:36 volumio volumio[958]: info: Setting timezone to Europe/Kiev Mar 10 19:51:36 volumio sudo[2369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 10 19:51:36 volumio sudo[2369]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:36 volumio sudo[2369]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:36 volumio sudo[2372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kiev /etc/localtime Mar 10 19:51:36 volumio sudo[2372]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:36 volumio sudo[2372]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:36 volumio sudo[2375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 10 19:51:36 volumio sudo[2375]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:36 volumio sudo[2375]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:36 volumio sudo[2378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kiev Mar 10 19:51:36 volumio sudo[2378]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:36 volumio sudo[2378]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:36 volumio volumio[958]: Updating browse sources language Mar 10 19:51:36 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:36 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:37 volumio volumio[958]: info: Fetching Streaming Services browse cache Mar 10 19:51:37 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:37 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 10 19:51:38 volumio volumio[958]: info: Loading i18n strings for locale ru Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 10 19:51:38 volumio volumio[958]: info: Setting timezone to Europe/Kiev Mar 10 19:51:38 volumio sudo[2395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 10 19:51:38 volumio sudo[2395]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:38 volumio sudo[2395]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:38 volumio sudo[2398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Kiev /etc/localtime Mar 10 19:51:38 volumio sudo[2398]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:38 volumio sudo[2398]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:38 volumio sudo[2401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 10 19:51:38 volumio sudo[2401]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:38 volumio sudo[2401]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:38 volumio sudo[2404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Kiev Mar 10 19:51:38 volumio sudo[2404]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:38 volumio sudo[2404]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 10 19:51:38 volumio sudo[2407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 10 19:51:38 volumio sudo[2407]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:38 volumio volumio[958]: Updating browse sources language Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:38 volumio sudo[2407]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:38 volumio volumio[958]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Mar 10 19:51:38 volumio volumio[958]: wlan0 Interface doesn't support scanning. Mar 10 19:51:38 volumio volumio[958]: info: Cannot use regular scanning, forcing with ap-force Mar 10 19:51:38 volumio sudo[2412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Mar 10 19:51:38 volumio sudo[2412]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:38 volumio sudo[2412]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:38 volumio volumio[958]: command failed: No such device (-19) Mar 10 19:51:38 volumio volumio[958]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Mar 10 19:51:38 volumio volumio[958]: command failed: No such device (-19) Mar 10 19:51:38 volumio volumio[958]: info: Fetching Streaming Services browse cache Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:51:38 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:38 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:38 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:51:39 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:39 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:40 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Mar 10 19:51:40 volumio volumio[958]: info: BOOT COMPLETED Mar 10 19:51:40 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Mar 10 19:51:40 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 10 19:51:40 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:40 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 10 19:51:41 volumio volumio[958]: info: Preparing to save Alsa Options, stopping services first Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:41 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::volumioPause Mar 10 19:51:41 volumio volumio[958]: info: CoreStateMachine::pause Mar 10 19:51:41 volumio volumio[958]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"XMOS USB AUDIO"},"disallowPush":true} Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:41 volumio volumio[958]: info: Setting mixer XMOS USB AUDIO for card XMOS USB AUDIO Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 10 19:51:41 volumio volumio[958]: info: Updating Volume Controller Parameters: Device: 5 Name: XMOS USB AUDIO Mixer: XMOS USB AUDIO Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 10 19:51:41 volumio volumio[958]: info: Disabling external Volume Control Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:41 volumio volumio[958]: info: Preparing to generate the ALSA configuration file Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:41 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:51:41 volumio volumio[958]: info: VolumeController:: Volume=100 Mute =false Mar 10 19:51:41 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:41 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 10 19:51:41 volumio volumio[958]: info: Asound.conf file unchanged, so no further update is needed Mar 10 19:51:41 volumio volumio[958]: info: Output device has changed, restarting MPD Mar 10 19:51:41 volumio sudo[2434]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 19:51:41 volumio sudo[2434]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:41 volumio volumio[958]: info: Output device has changed, restarting Shairport Sync Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:41 volumio sudo[2434]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:41 volumio sudo[2437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 19:51:41 volumio sudo[2437]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:41 volumio systemd[1]: Stopping Music Player Daemon... Mar 10 19:51:41 volumio volumio[958]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 19:51:41 volumio systemd[1]: mpd.service: Succeeded. Mar 10 19:51:41 volumio systemd[1]: Stopped Music Player Daemon. Mar 10 19:51:41 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:41 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:51:41 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:41 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:51:41 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:41 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:51:41 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:51:41 volumio volumio[958]: info: Got it Mar 10 19:51:41 volumio volumio[958]: info: Got it Mar 10 19:51:41 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:51:41 volumio volumio[958]: info: MPD Permissions set Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio systemd[1]: Starting Music Player Daemon... Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:41 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:51:41 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:51:41 volumio volumio[958]: info: Starting Shairport Sync Mar 10 19:51:41 volumio sudo[2450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 19:51:41 volumio sudo[2450]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:41 volumio sudo[2442]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 10 19:51:41 volumio sudo[2442]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:41 volumio sudo[2442]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:41 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 19:51:41 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 19:51:41 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 19:51:41 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 19:51:41 volumio sudo[2450]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:41 volumio volumio[958]: info: Shairport-Sync Started Mar 10 19:51:42 volumio mpd[2453]: Mar 10 19:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 10 19:51:42 volumio systemd[1]: Started Music Player Daemon. Mar 10 19:51:42 volumio sudo[2437]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:42 volumio volumio[958]: error: updateQueue error: null Mar 10 19:51:42 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Mar 10 19:51:42 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 10 19:51:42 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Mar 10 19:51:42 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Mar 10 19:51:42 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 10 19:51:43 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 10 19:51:43 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:51:43 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:43 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:43 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:51:43 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:43 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:44 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Mar 10 19:51:44 volumio volumio[958]: info: CoreCommandRouter::Reload Ui Mar 10 19:51:44 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Mar 10 19:51:44 volumio volumio[958]: info: Wizard terminated Successfully Mar 10 19:51:44 volumio volumio[958]: info: CoreCommandRouter::volumiosetStartupVolume Mar 10 19:51:44 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 19:51:45 volumio sudo[2467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:51:45 volumio sudo[2467]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:45 volumio sudo[2467]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:45 volumio sudo[2469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:45 volumio sudo[2469]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:45 volumio sudo[2469]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:45 volumio volumio[958]: verbose: New Socket.io Connection to 192.168.0.119 from 192.168.0.103 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 OPR/117.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 10 19:51:45 volumio volumio[958]: info: CoreStateMachine::getcurrentVolume Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:51:45 volumio sudo[2476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 19:51:45 volumio sudo[2476]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:45 volumio sudo[2476]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:45 volumio sudo[2478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 19:51:45 volumio sudo[2478]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 19:51:45 volumio sudo[2478]: pam_unix(sudo:session): session closed for user root Mar 10 19:51:45 volumio volumio[958]: info: VolumeController:: Volume=100 Mute =false Mar 10 19:51:45 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:45 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:45 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 10 19:51:45 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 19:51:45 volumio volumio[958]: verbose: New Socket.io Connection to 192.168.0.119 from 192.168.0.103 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/132.0.0.0 Safari/537.36 OPR/117.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Mar 10 19:51:45 volumio volumio[958]: info: VolumeController:: Volume=100 Mute =false Mar 10 19:51:45 volumio volumio[958]: info: CoreStateMachine::pushState Mar 10 19:51:45 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:45 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 10 19:51:45 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:45 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:45 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:45 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:45 volumio volumio[958]: info: Listing playlists Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:45 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 10 19:51:45 volumio volumio[958]: 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: 6 Mar 10 19:51:46 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:46 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:47 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:47 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:47 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:47 volumio volumio[958]: 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: 7 Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:47 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:47 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:47 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:47 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::volumioGetVisibleSources Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:48 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 10 19:51:48 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:48 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:48 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:48 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:48 volumio volumio[958]: info: Listing playlists Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 10 19:51:48 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:48 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:49 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Mar 10 19:51:49 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:49 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:49 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:49 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:49 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:49 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:49 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:49 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:49 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 10 19:51:50 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Mar 10 19:51:50 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Mar 10 19:51:51 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 10 19:51:51 volumio volumio[958]: info: Received Get System Info Mar 10 19:51:51 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:51:51 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:51:51 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:51:51 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:51:51 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:51:51 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:51:52 volumio volumio[958]: info: CoreCommandRouter::volumioGetQueue Mar 10 19:51:52 volumio volumio[958]: info: CoreStateMachine::getQueue Mar 10 19:51:52 volumio volumio[958]: info: CorePlayQueue::getQueue Mar 10 19:51:52 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 10 19:51:52 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:51:53 volumio volumio-remote-updater[708]: No test mode Mar 10 19:51:53 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:51:53 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:51:53 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:51:53 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:51:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 10 19:51:57 volumio volumio[958]: info: CoreCommandRouter::Close All Modals sent Mar 10 19:51:57 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Mar 10 19:51:57 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 10 19:52:01 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:52:01 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:52:02 volumio volumio[958]: info: Retrieving Cloud Streaming UI Mar 10 19:52:02 volumio volumio[958]: info: Getting Tidal Cloud Configuration Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:52:02 volumio volumio[958]: info: Getting Qobuz Cloud Configuration Mar 10 19:52:02 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:52:02 volumio volumio[958]: info: Getting Spotify Cloud Configuration Mar 10 19:52:02 volumio volumio[958]: info: Asking plugin for UI Config Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:52:02 volumio volumio[958]: info: Saving Spotify Acccount Mar 10 19:52:02 volumio volumio[958]: info: Got Tidal Cloud Configuration Mar 10 19:52:02 volumio volumio[958]: info: Got it Mar 10 19:52:02 volumio volumio[958]: info: Got it Mar 10 19:52:02 volumio volumio[958]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 10 19:52:02 volumio volumio[958]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::volumioGetBrowseSources Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 19:52:02 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 10 19:52:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:52:03 volumio volumio[958]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 10 19:52:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 10 19:52:03 volumio volumio[958]: info: Received Get System Version Mar 10 19:52:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:52:03 volumio volumio[958]: info: Received Get System Info Mar 10 19:52:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:52:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:52:03 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:52:03 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:52:03 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:52:03 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 10 19:52:05 volumio volumio[958]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 10 19:52:05 volumio volumio[958]: info: Received Get System Version Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 19:52:05 volumio volumio[958]: info: Received Get System Info Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 19:52:05 volumio volumio[958]: info: Discovery: Getting this device information Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 10 19:52:05 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 10 19:52:05 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:52:06 volumio volumio-remote-updater[708]: No test mode Mar 10 19:52:06 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:52:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:52:06 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:52:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:52:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 10 19:52:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:52:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 19:52:06 volumio volumio-remote-updater[708]: No test mode Mar 10 19:52:06 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:52:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:52:06 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:52:06 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:52:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 10 19:52:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 10 19:52:08 volumio systemd[1]: systemd-timedated.service: Succeeded. Mar 10 19:52:08 volumio volumio-remote-updater[708]: No test mode Mar 10 19:52:08 volumio volumio-remote-updater[708]: No alpha test mode Mar 10 19:52:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 10 19:52:08 volumio volumio[958]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 10 19:52:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 10 19:52:10 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 19:52:14 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 10 19:52:17 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 10 19:52:17 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 10 19:52:17 volumio volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 19:52:17 volumio volumio[958]: Error: getaddrinfo -3007 Mar 10 19:52:17 volumio volumio[958]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Mar 10 19:52:17 volumio volumio[958]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Mar 10 19:52:17 volumio volumio[958]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Mar 10 19:52:17 volumio volumio[958]: code: -3007, Mar 10 19:52:17 volumio volumio[958]: errno: -3007, Mar 10 19:52:17 volumio volumio[958]: syscall: 'getaddrinfo' Mar 10 19:52:17 volumio volumio[958]: } Mar 10 19:52:17 volumio volumio[958]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 19:52:17 volumio sudo[2628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-10 19:51 Mar 10 19:52:17 volumio sudo[2628]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:15:38 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9e0e048b157c8fb0f19240808f3da58b"