-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Mon 2024-11-25 19:58:15 MSK. -- Nov 25 19:57:07 volumio systemd-timedated[979]: Changed local time to Mon Nov 25 19:57:07 2024 Nov 25 19:57:07 volumio sudo[970]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:07 volumio volumio-time-update[624]: volumio-time-update-util: System time updated successfully. Nov 25 19:57:07 volumio systemd[1]: Starting Daily apt download activities... Nov 25 19:57:07 volumio systemd[1]: Started Volumio Time Update Utility. Nov 25 19:57:07 volumio wireless.js[605]: trying... Nov 25 19:57:07 volumio sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:07 volumio sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:07 volumio sudo[1003]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:08 volumio systemd[1]: apt-daily.service: Succeeded. Nov 25 19:57:08 volumio systemd[1]: Started Daily apt download activities. Nov 25 19:57:08 volumio ntpd[808]: Listen normally on 3 eth0 192.168.50.65:123 Nov 25 19:57:08 volumio ntpd[808]: new interface(s) found: waking up resolver Nov 25 19:57:08 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Nov 25 19:57:08 volumio wireless.js[605]: trying... Nov 25 19:57:08 volumio sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:08 volumio sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:08 volumio sudo[1040]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:08 volumio volumio-remote-updater[642]: [2024-11-25 19:57:08] [info] asio async_connect error: system:111 (Connection refused) Nov 25 19:57:08 volumio volumio-remote-updater[642]: [2024-11-25 19:57:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 19:57:08 volumio volumio-remote-updater[642]: [2024-11-25 19:57:08] [error] handle_connect error: Underlying Transport Error Nov 25 19:57:09 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Nov 25 19:57:09 volumio systemd[1]: Started Daily apt upgrade and clean activities. Nov 25 19:57:09 volumio nmbd[750]: [2024/11/25 19:57:09.751186, 0] ../source3/nmbd/nmbd_winsserver.c:687(initialise_wins) Nov 25 19:57:09 volumio nmbd[750]: initialise_wins: Failed to parse name when parsing line Nov 25 19:57:09 volumio nmbd[750]: [2024/11/25 19:57:09.753146, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 25 19:57:09 volumio nmbd[750]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 25 19:57:09 volumio systemd[1]: Started Samba NMB Daemon. Nov 25 19:57:09 volumio wireless.js[605]: trying... Nov 25 19:57:09 volumio sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:09 volumio sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:09 volumio sudo[1089]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:09 volumio systemd[1]: Starting Samba Winbind Daemon... Nov 25 19:57:10 volumio winbindd[1086]: [2024/11/25 19:57:10.246455, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 25 19:57:10 volumio winbindd[1086]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 25 19:57:10 volumio winbindd[1086]: [2024/11/25 19:57:10.370890, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 25 19:57:10 volumio winbindd[1086]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 25 19:57:10 volumio systemd[1]: Started Samba Winbind Daemon. Nov 25 19:57:10 volumio systemd[1]: Starting Samba SMB Daemon... Nov 25 19:57:10 volumio wireless.js[605]: trying... Nov 25 19:57:10 volumio sudo[1096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:10 volumio sudo[1096]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:10 volumio sudo[1096]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:11 volumio dhcpcd[898]: eth0: leased 192.168.50.65 for 86400 seconds Nov 25 19:57:11 volumio dhcpcd[898]: eth0: adding route to 192.168.50.0/24 Nov 25 19:57:11 volumio dhcpcd[898]: eth0: adding default route via 192.168.50.1 Nov 25 19:57:11 volumio wpa_supplicant[911]: wlan0: Trying to associate with SSID 'kuz' Nov 25 19:57:11 volumio dhcpcd[898]: forked to background, child pid 1121 Nov 25 19:57:11 volumio sudo[897]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: carrier acquired Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: connected to Access Point `kuz' Nov 25 19:57:11 volumio wpa_supplicant[911]: wlan0: Associated with fc:34:97:0b:90:b8 Nov 25 19:57:11 volumio wpa_supplicant[911]: wlan0: CTRL-EVENT-CONNECTED - Connection to fc:34:97:0b:90:b8 completed [id=0 id_str=] Nov 25 19:57:11 volumio wpa_supplicant[911]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Nov 25 19:57:11 volumio wpa_supplicant[911]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=FR Nov 25 19:57:11 volumio smbd[1094]: [2024/11/25 19:57:11.423480, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 25 19:57:11 volumio systemd[1]: Started Samba SMB Daemon. Nov 25 19:57:11 volumio smbd[1094]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: IAID 01:6e:d1:2e Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: adding address fe80::6cab:af4c:aa19:7ee2 Nov 25 19:57:11 volumio dhcpcd[1121]: ipv6_addaddr1: Permission denied Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: carrier lost Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: carrier acquired Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: IAID 01:6e:d1:2e Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: rebinding lease of 192.168.50.64 Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: probing address 192.168.50.64/24 Nov 25 19:57:11 volumio wireless.js[605]: trying... Nov 25 19:57:11 volumio sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:11 volumio sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:11 volumio dhcpcd[1121]: wlan0: soliciting an IPv6 router Nov 25 19:57:11 volumio sudo[1146]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:12 volumio wireless.js[605]: trying... Nov 25 19:57:12 volumio sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:12 volumio sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:12 volumio sudo[1149]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:13 volumio wireless.js[605]: trying... Nov 25 19:57:13 volumio sudo[1155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:13 volumio sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:13 volumio sudo[1155]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:14 volumio wireless.js[605]: trying... Nov 25 19:57:14 volumio sudo[1158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:14 volumio sudo[1158]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:14 volumio sudo[1158]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:15 volumio wireless.js[605]: trying... Nov 25 19:57:15 volumio sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:15 volumio sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:15 volumio sudo[1161]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:16 volumio wireless.js[605]: trying... Nov 25 19:57:16 volumio sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:16 volumio sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:16 volumio sudo[1164]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:17 volumio dhcpcd[1121]: wlan0: leased 192.168.50.64 for 86400 seconds Nov 25 19:57:17 volumio avahi-daemon[629]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.50.64. Nov 25 19:57:17 volumio dhcpcd[1121]: wlan0: adding route to 192.168.50.0/24 Nov 25 19:57:17 volumio avahi-daemon[629]: New relevant interface wlan0.IPv4 for mDNS. Nov 25 19:57:17 volumio dhcpcd[1121]: wlan0: adding default route via 192.168.50.1 Nov 25 19:57:17 volumio avahi-daemon[629]: Registering new address record for 192.168.50.64 on wlan0.IPv4. Nov 25 19:57:17 volumio wireless.js[605]: trying... Nov 25 19:57:17 volumio sudo[1187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:57:17 volumio sudo[1187]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:17 volumio sudo[1187]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:17 volumio wireless.js[605]: Connected to: ----kuz Nov 25 19:57:17 volumio wireless.js[605]: ---- Nov 25 19:57:17 volumio sudo[1190]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:57:17 volumio sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:17 volumio sudo[1190]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:17 volumio wireless.js[605]: ... joined AP, wlan0 IPv4 is 192.168.50.64, ipV6 is undefined Nov 25 19:57:17 volumio wireless.js[605]: It's done! AP Nov 25 19:57:18 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 25 19:57:18 volumio systemd[1]: Started Wireless Services. Nov 25 19:57:18 volumio systemd[1]: Started Volumio Backend Module. Nov 25 19:57:18 volumio systemd[1]: Started Volumio Cpu Tweaker. Nov 25 19:57:18 volumio systemd[1]: Reached target Multi-User System. Nov 25 19:57:18 volumio systemd[1]: Reached target Graphical Interface. Nov 25 19:57:18 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 25 19:57:18 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 25 19:57:18 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 25 19:57:18 volumio systemd[1]: Startup finished in 18.348s (kernel) + 28.870s (userspace) = 47.219s. Nov 25 19:57:18 volumio volumio-cpu-tweak[1196]: Setting RT Priority for mpd Nov 25 19:57:18 volumio volumio-cpu-tweak[1196]: Setting MPD Affinity Nov 25 19:57:18 volumio volumio-cpu-tweak[1196]: pid 826's current affinity mask: f Nov 25 19:57:18 volumio volumio-cpu-tweak[1196]: pid 826's new affinity mask: 3 Nov 25 19:57:18 volumio volumio-cpu-tweak[1196]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 25 19:57:18 volumio volumio-cpu-tweak[1196]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 25 19:57:18 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 25 19:57:18 volumio ntpd[808]: Listen normally on 4 wlan0 192.168.50.64:123 Nov 25 19:57:18 volumio ntpd[808]: new interface(s) found: waking up resolver Nov 25 19:57:18 volumio volumio-remote-updater[642]: [2024-11-25 19:57:18] [info] asio async_connect error: system:111 (Connection refused) Nov 25 19:57:18 volumio volumio-remote-updater[642]: [2024-11-25 19:57:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 25 19:57:18 volumio volumio-remote-updater[642]: [2024-11-25 19:57:18] [error] handle_connect error: Underlying Transport Error Nov 25 19:57:21 volumio volumio[1195]: info: ------------------------------------------- Nov 25 19:57:21 volumio volumio[1195]: info: ----- Volumio3 ---- Nov 25 19:57:21 volumio volumio[1195]: info: ------------------------------------------- Nov 25 19:57:21 volumio volumio[1195]: info: ----- System startup ---- Nov 25 19:57:21 volumio volumio[1195]: info: ------------------------------------------- Nov 25 19:57:23 volumio volumio[1195]: info: MYVOLUMIO Environment detected Nov 25 19:57:23 volumio volumio[1195]: info: Plugin folders cleanup Nov 25 19:57:23 volumio volumio[1195]: info: Scanning into folder /volumio/app/plugins/ Nov 25 19:57:23 volumio volumio[1195]: info: Scanning category audio_interface Nov 25 19:57:23 volumio volumio[1195]: info: Scanning category miscellanea Nov 25 19:57:23 volumio volumio[1195]: info: Scanning category music_service Nov 25 19:57:23 volumio volumio[1195]: info: Scanning category plugins.json Nov 25 19:57:23 volumio volumio[1195]: info: Scanning category system_controller Nov 25 19:57:23 volumio volumio[1195]: info: Scanning category user_interface Nov 25 19:57:23 volumio volumio[1195]: info: Scanning into folder /data/plugins/ Nov 25 19:57:23 volumio volumio[1195]: info: Plugin folders cleanup completed Nov 25 19:57:23 volumio volumio[1195]: info: ------------------------------------------- Nov 25 19:57:23 volumio volumio[1195]: info: ----- Core plugins startup ---- Nov 25 19:57:23 volumio volumio[1195]: info: ------------------------------------------- Nov 25 19:57:23 volumio volumio[1195]: info: Loading plugins from folder /volumio/app/plugins/ Nov 25 19:57:23 volumio volumio[1195]: info: Adding plugin upnp to MyMusic Plugins Nov 25 19:57:23 volumio volumio[1195]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 25 19:57:23 volumio volumio[1195]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 25 19:57:23 volumio volumio[1195]: info: Loading plugins from folder /data/plugins/ Nov 25 19:57:23 volumio volumio[1195]: info: Loading plugin "system"... Nov 25 19:57:23 volumio volumio[1195]: info: Loading plugin "appearance"... Nov 25 19:57:24 volumio systemd[1]: systemd-fsckd.service: Succeeded. Nov 25 19:57:25 volumio volumio[1195]: info: Loading plugin "network"... Nov 25 19:57:25 volumio volumio[1195]: info: Refreshing Cached IP Addresses Nov 25 19:57:25 volumio sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 19:57:25 volumio sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:25 volumio sudo[1230]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:25 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:57:25 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:25 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:25 volumio volumio[1195]: info: Loading plugin "services"... Nov 25 19:57:25 volumio volumio[1195]: info: Loading plugin "alsa_controller"... Nov 25 19:57:25 volumio sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 25 19:57:25 volumio sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:25 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:57:25 volumio volumio[1195]: info: Loading plugin "wizard"... Nov 25 19:57:25 volumio volumio[1195]: info: Loading plugin "networkfs"... Nov 25 19:57:26 volumio volumio[1195]: info: Starting Udev Watcher for removable devices Nov 25 19:57:26 volumio sudo[1258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kuzaru,password=NeKuRu125,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.1/media\\MUSIC /mnt/NAS/kuz Nov 25 19:57:26 volumio sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:26 volumio volumio[1195]: info: Ignoring mount for partition: boot Nov 25 19:57:26 volumio volumio[1195]: info: Ignoring mount for partition: volumio Nov 25 19:57:26 volumio volumio[1195]: info: Ignoring mount for partition: volumio_data Nov 25 19:57:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 19:57:26 volumio volumio[1195]: info: Loading plugin "volumio_command_line_client"... Nov 25 19:57:26 volumio volumio[1195]: info: Loading plugin "upnp"... Nov 25 19:57:26 volumio volumio[1195]: info: [1732553846124] Starting Upmpd Daemon Nov 25 19:57:26 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 19:57:26 volumio volumio[1195]: info: Loading plugin "my_music"... Nov 25 19:57:26 volumio volumio[1195]: info: Loading plugin "mpd"... Nov 25 19:57:26 volumio kernel: Key type cifs.spnego registered Nov 25 19:57:26 volumio kernel: Key type cifs.idmap registered Nov 25 19:57:26 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Nov 25 19:57:26 volumio kernel: CIFS: Attempting to mount //192.168.1.1/media/MUSIC Nov 25 19:57:26 volumio volumio[1195]: info: Loading plugin "upnp_browser"... Nov 25 19:57:27 volumio volumio[1195]: info: Loading plugin "alarm-clock"... Nov 25 19:57:27 volumio volumio[1195]: info: Loading plugin "airplay_emulation"... Nov 25 19:57:27 volumio volumio[1195]: info: Starting Shairport Sync Nov 25 19:57:27 volumio volumio[1195]: info: Loading plugin "last_100"... Nov 25 19:57:27 volumio volumio[1195]: info: Loading plugin "webradio"... Nov 25 19:57:27 volumio volumio[1195]: info: Loading plugin "i2s_dacs"... Nov 25 19:57:27 volumio volumio[1195]: info: I2S DAC not set, start Auto-detection Nov 25 19:57:27 volumio volumio[1195]: info: Loading plugin "volumiodiscovery"... Nov 25 19:57:28 volumio volumio[1195]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 19:57:28 volumio volumio[1195]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:57:28 volumio node[1195]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 19:57:28 volumio volumio[1195]: *** WARNING *** For more information see Nov 25 19:57:28 volumio volumio[1195]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 19:57:28 volumio volumio[1195]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:57:28 volumio volumio[1195]: *** WARNING *** For more information see Nov 25 19:57:28 volumio node[1195]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:57:28 volumio node[1195]: *** WARNING *** For more information see Nov 25 19:57:28 volumio node[1195]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 19:57:28 volumio node[1195]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:57:28 volumio node[1195]: *** WARNING *** For more information see Nov 25 19:57:28 volumio volumio[1195]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 25 19:57:28 volumio volumio[1195]: info: Discovery: Started advertising with name: Volumio Nov 25 19:57:28 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 19:57:28 volumio volumio[1195]: info: Loading plugin "outputs"... Nov 25 19:57:28 volumio volumio[1195]: info: Loading plugin "albumart"... Nov 25 19:57:28 volumio volumio[1195]: info: Plugin example_plugin is not enabled Nov 25 19:57:28 volumio volumio[1195]: info: Loading plugin "inputs"... Nov 25 19:57:28 volumio volumio[1195]: info: Loading plugin "updater_comm"... Nov 25 19:57:28 volumio volumio[1195]: info: Plugin mpdemulation is not enabled Nov 25 19:57:28 volumio volumio[1195]: info: Loading plugin "rest_api"... Nov 25 19:57:28 volumio volumio[1195]: info: Loading plugin "websocket"... Nov 25 19:57:28 volumio volumio[1195]: Forking 3 albumart workers Nov 25 19:57:28 volumio volumio[1195]: info: Starting Socket.io Server version 2.3.0 Nov 25 19:57:28 volumio volumio[1195]: info: Loading i18n strings for locale ru Nov 25 19:57:28 volumio volumio[1195]: Updating browse sources language Nov 25 19:57:28 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:57:28 volumio volumio-remote-updater[642]: [2024-11-25 19:57:28] [connect] Successful connection Nov 25 19:57:28 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::initPlayerControls Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:57:29 volumio volumio[1195]: Express server listening on port 3000 Nov 25 19:57:29 volumio volumio[1195]: [Metrics] WebUI: 8s 827.18ms Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::resetVolumioState Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::getcurrentVolume Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:29 volumio sudo[1241]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:29 volumio volumio[1195]: info: Cannot read play queue from file Nov 25 19:57:29 volumio volumio[1195]: info: Volumio Network Manager: Network status updated: 3 Nov 25 19:57:29 volumio volumio-remote-updater[642]: [2024-11-25 19:57:29] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732553848 101 Nov 25 19:57:29 volumio volumio[1195]: 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: 1 Nov 25 19:57:29 volumio volumio[1195]: info: Setting Device type: Raspberry PI Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::setRepeat null single undefined Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::pushState Nov 25 19:57:29 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::volumioPushState Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::setRandom null Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::pushState Nov 25 19:57:29 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::volumioPushState Nov 25 19:57:29 volumio volumio[1195]: info: VolumeController:: Volume=46 Mute =false Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::pushState Nov 25 19:57:29 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::volumioPushState Nov 25 19:57:29 volumio volumio[1195]: info: CoreStateMachine::updateTrackBlock Nov 25 19:57:29 volumio volumio[1195]: info: CorePlayQueue::getTrackBlock Nov 25 19:57:29 volumio volumio[1195]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 19:57:29 volumio volumio[1195]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 25 19:57:29 volumio volumio[1195]: Starting albumart workers Nov 25 19:57:29 volumio volumio[1195]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Nov 25 19:57:29 volumio volumio[1195]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 25 19:57:29 volumio volumio[1195]: Starting albumart workers Nov 25 19:57:30 volumio volumio[1195]: Starting albumart workers Nov 25 19:57:30 volumio volumio[1195]: info: Discovery: adding 7e56b705-e241-436c-9947-f9bd2a377c50 Nov 25 19:57:30 volumio volumio[1195]: info: Discovery: Found device Volumio Nov 25 19:57:30 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:30 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:30 volumio volumio[1195]: info: Discovery: this is already registered, 7e56b705-e241-436c-9947-f9bd2a377c50 Nov 25 19:57:30 volumio volumio[1195]: info: Discovery: Found device Volumio Nov 25 19:57:30 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:30 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:30 volumio volumio[1195]: info: VolumeController:: Volume=46 Mute =false Nov 25 19:57:30 volumio volumio[1195]: info: CoreStateMachine::pushState Nov 25 19:57:30 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:30 volumio volumio[1195]: info: CoreCommandRouter::volumioPushState Nov 25 19:57:36 volumio sudo[1360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 19:57:36 volumio sudo[1360]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:36 volumio sudo[1360]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:36 volumio sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:57:36 volumio sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:36 volumio sudo[1362]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:36 volumio sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 25 19:57:36 volumio sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:36 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 25 19:57:36 volumio sudo[1366]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:36 volumio volumio[1195]: info: Upmpdcli Daemon Started Nov 25 19:57:36 volumio sudo[1258]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:36 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 25 19:57:36 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Nov 25 19:57:36 volumio volumio[1195]: info: Cannot mount NAS kuz at system boot, trial number 1 ,retrying in 5 seconds Nov 25 19:57:36 volumio volumio[1195]: info: Completed loading Core Plugins Nov 25 19:57:36 volumio volumio[1195]: info: Preparing to generate the ALSA configuration file Nov 25 19:57:36 volumio volumio[1195]: info: Asound.conf file unchanged, so no further update is needed Nov 25 19:57:36 volumio volumio[1195]: info: Output device has changed, restarting MPD Nov 25 19:57:36 volumio volumio[1195]: info: Output device has changed, restarting Shairport Sync Nov 25 19:57:36 volumio volumio[1368]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 25 19:57:36 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 19:57:36 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:36 volumio sudo[1385]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:36 volumio sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 19:57:36 volumio sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:36 volumio systemd[1]: Stopping Music Player Daemon... Nov 25 19:57:36 volumio volumio[1195]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:57:36 volumio volumio[1195]: info: ___________ START PLUGINS ___________ Nov 25 19:57:36 volumio volumio[1195]: info: ControllerMpd::onStart: Initializing MPD Nov 25 19:57:36 volumio volumio[1195]: info: Creating MPD Configuration file Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:57:36 volumio volumio[1195]: info: [1732553856704] CoreMusicLibrary::Adding element Медиа-серверы Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:57:36 volumio sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 19:57:36 volumio sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:36 volumio sudo[1394]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:36 volumio sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 19:57:36 volumio sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:36 volumio systemd[1]: mpd.service: Succeeded. Nov 25 19:57:36 volumio systemd[1]: Stopped Music Player Daemon. Nov 25 19:57:36 volumio volumio[1195]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:36 volumio systemd[1]: Starting Music Player Daemon... Nov 25 19:57:36 volumio volumio[1195]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:57:36 volumio volumio[1195]: info: [1732553856919] CoreMusicLibrary::Adding element Last_100 Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:57:36 volumio volumio[1195]: info: [1732553856924] CoreMusicLibrary::Adding element Webradio Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:57:36 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:57:36 volumio volumio[1195]: info: Initializing BBC Radios Nov 25 19:57:37 volumio sudo[1402]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 19:57:37 volumio sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:37 volumio systemd[1]: systemd-timedated.service: Succeeded. Nov 25 19:57:37 volumio sudo[1402]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: Volumio Calling Home Nov 25 19:57:37 volumio volumio[1195]: info: MPD Permissions set Nov 25 19:57:37 volumio volumio[1195]: info: MPD Permissions set Nov 25 19:57:37 volumio volumio[1195]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Nov 25 19:57:37 volumio volumio[1195]: info: Volumio called home Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:57:37 volumio volumio[1195]: info: Starting Shairport Sync Nov 25 19:57:37 volumio volumio[1195]: info: Starting Shairport Sync Nov 25 19:57:37 volumio sudo[1433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:57:37 volumio sudo[1433]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:37 volumio volumio[1195]: info: Starting Shairport Sync Nov 25 19:57:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 25 19:57:37 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 25 19:57:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 25 19:57:38 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:38 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:38 volumio sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:57:38 volumio sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:38 volumio sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:57:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 25 19:57:38 volumio sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:38 volumio sudo[1433]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:38 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 25 19:57:38 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 25 19:57:38 volumio systemd[1]: shairport-sync.service: Succeeded. Nov 25 19:57:38 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 25 19:57:38 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 25 19:57:38 volumio sudo[1438]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:38 volumio sudo[1436]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:38 volumio volumio[1195]: info: Shairport-Sync Started Nov 25 19:57:38 volumio volumio[1195]: Error adding Membership: Error: addMembership EINVAL Nov 25 19:57:38 volumio volumio[1195]: info: Shairport-Sync Started Nov 25 19:57:38 volumio volumio[1195]: info: Shairport-Sync Started Nov 25 19:57:38 volumio mpd[1419]: Nov 25 19:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 19:57:38 volumio systemd[1]: Started Music Player Daemon. Nov 25 19:57:38 volumio sudo[1387]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:38 volumio sudo[1396]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:38 volumio volumio[1195]: info: Completed starting Core Plugins Nov 25 19:57:38 volumio volumio[1195]: info: ------------------------------------------- Nov 25 19:57:38 volumio volumio[1195]: info: ----- MyVolumio plugins startup ---- Nov 25 19:57:38 volumio volumio[1195]: info: ------------------------------------------- Nov 25 19:57:38 volumio volumio[1195]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 25 19:57:39 volumio volumio[1195]: info: MPD running with PID1419 Nov 25 19:57:39 volumio volumio[1195]: ,establishing connection Nov 25 19:57:39 volumio volumio[1195]: error: MPD error: The expression evaluated to a falsy value: Nov 25 19:57:39 volumio volumio[1195]: assert.ok(self.idling) Nov 25 19:57:39 volumio volumio[1195]: error: The expression evaluated to a falsy value: Nov 25 19:57:39 volumio volumio[1195]: assert.ok(self.idling) Nov 25 19:57:39 volumio volumio[1195]: error: MPD error: The expression evaluated to a falsy value: Nov 25 19:57:39 volumio volumio[1195]: assert.ok(self.idling) Nov 25 19:57:39 volumio volumio[1195]: error: The expression evaluated to a falsy value: Nov 25 19:57:39 volumio volumio[1195]: assert.ok(self.idling) Nov 25 19:57:39 volumio volumio[1195]: error: updateQueue error: null Nov 25 19:57:41 volumio sudo[1451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kuzaru,password=NeKuRu125,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.1/media\\MUSIC /mnt/NAS/kuz Nov 25 19:57:41 volumio sudo[1451]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:41 volumio kernel: CIFS: Attempting to mount //192.168.1.1/media/MUSIC Nov 25 19:57:44 volumio volumio[1195]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 25 19:57:45 volumio volumio[1368]: .....................................++++ Nov 25 19:57:47 volumio sudo[1473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 19:57:47 volumio sudo[1473]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:47 volumio sudo[1473]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:47 volumio sudo[1475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:57:47 volumio sudo[1475]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:47 volumio sudo[1475]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:47 volumio volumio[1195]: verbose: New Socket.io Connection to 192.168.50.65 from 192.168.50.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 25 19:57:48 volumio volumio[1195]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 25 19:57:48 volumio volumio[1195]: info: Adding plugin bluetooth to MyMusic Plugins Nov 25 19:57:48 volumio volumio[1195]: info: Adding plugin multiroom to MyMusic Plugins Nov 25 19:57:48 volumio volumio[1195]: info: Adding plugin metavolumio to MyMusic Plugins Nov 25 19:57:49 volumio volumio[1195]: info: Adding plugin cd_controller to MyMusic Plugins Nov 25 19:57:49 volumio volumio[1195]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 25 19:57:49 volumio volumio[1195]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 25 19:57:49 volumio volumio[1195]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 25 19:57:50 volumio volumio[1195]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 25 19:57:50 volumio volumio[1195]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 25 19:57:50 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:50 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:50 volumio volumio[1195]: info: Starting MyVolumio Remote Streaming Endpoints Nov 25 19:57:50 volumio volumio[1195]: info: MyVolumio login type: Token Nov 25 19:57:50 volumio volumio[1195]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 25 19:57:50 volumio volumio[1195]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 25 19:57:51 volumio sudo[1451]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:51 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 25 19:57:51 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Nov 25 19:57:52 volumio volumio[1195]: info: Starting Streaming Service Transparent Proxy Nov 25 19:57:52 volumio volumio[1195]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 25 19:57:52 volumio volumio[1195]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 25 19:57:52 volumio volumio[1195]: info: Streaming services startup Nov 25 19:57:52 volumio volumio[1195]: info: Starting Streaming Daemon Nov 25 19:57:53 volumio sudo[1485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 19:57:53 volumio sudo[1485]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:53 volumio volumio[1195]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 25 19:57:53 volumio sudo[1485]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:53 volumio volumio[1195]: error: Cannot start Volumio Streaming Daemon Nov 25 19:57:53 volumio volumio[1195]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 25 19:57:53 volumio volumio[1195]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 25 19:57:53 volumio volumio[1195]: info: Cannot mount NAS kuz at system boot, trial number 2 ,retrying in 5 seconds Nov 25 19:57:53 volumio sudo[1496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 19:57:53 volumio sudo[1496]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:53 volumio sudo[1498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:57:53 volumio sudo[1498]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:53 volumio sudo[1496]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:53 volumio sudo[1498]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:53 volumio volumio[1195]: verbose: New Socket.io Connection to 192.168.50.65 from 192.168.50.95 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:53 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 19:57:53 volumio volumio[1195]: info: Received Get System Info Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 19:57:53 volumio volumio[1195]: info: Discovery: Getting this device information Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:53 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:53 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:53 volumio volumio[1195]: info: Listing playlists Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 25 19:57:53 volumio volumio[1195]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 25 19:57:53 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 25 19:57:54 volumio volumio[1195]: STREAMING PROXY: Starting server on port 3245 Nov 25 19:57:54 volumio volumio[1195]: Node JS runtime: 14 Nov 25 19:57:54 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:54 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 25 19:57:55 volumio volumio[1195]: info: Received Get System Info Nov 25 19:57:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 19:57:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 19:57:55 volumio volumio[1195]: info: Discovery: Getting this device information Nov 25 19:57:55 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:55 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:57:55 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 25 19:57:55 volumio volumio[1195]: info: MyVolumio token set successfully Nov 25 19:57:55 volumio volumio[1195]: info: MYVOLUMIO: Adding device Nov 25 19:57:55 volumio volumio[1195]: info: MYVOLUMIO: Evaluating Server Nov 25 19:57:56 volumio volumio[1195]: info: MyVolumio status changed Nov 25 19:57:56 volumio volumio[1195]: info: Streaming services startup Nov 25 19:57:56 volumio volumio[1195]: info: Starting Streaming Daemon Nov 25 19:57:56 volumio volumio[1195]: info: Removing browser output: myVolumio user plan is not superstar Nov 25 19:57:56 volumio volumio[1195]: info: Removing audio output: Nov 25 19:57:56 volumio volumio[1195]: info: Stoppping Tunnel 1 Nov 25 19:57:56 volumio sudo[1555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 19:57:56 volumio sudo[1555]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 25 19:57:56 volumio volumio[1195]: info: Received Get System Info Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 19:57:56 volumio volumio[1195]: info: Discovery: Getting this device information Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:57:56 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 19:57:56 volumio sudo[1555]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:56 volumio volumio[1195]: info: Retrieving Cloud Streaming UI Nov 25 19:57:56 volumio sudo[1567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 25 19:57:56 volumio sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:56 volumio volumio[1195]: error: Cannot start Volumio Streaming Daemon Nov 25 19:57:56 volumio volumio[1195]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 25 19:57:56 volumio volumio[1195]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 25 19:57:56 volumio volumio[1195]: info: Getting Tidal Cloud Configuration Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 19:57:56 volumio volumio[1195]: info: Getting Qobuz Cloud Configuration Nov 25 19:57:56 volumio volumio[1195]: info: Asking plugin for UI Config Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 19:57:56 volumio volumio[1195]: info: Getting Spotify Cloud Configuration Nov 25 19:57:56 volumio volumio[1195]: info: Asking plugin for UI Config Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 19:57:56 volumio volumio[1195]: info: Saving Spotify Acccount Nov 25 19:57:56 volumio volumio[1195]: info: Got Tidal Cloud Configuration Nov 25 19:57:56 volumio volumio[1195]: info: Got it Nov 25 19:57:56 volumio volumio[1195]: info: Got it Nov 25 19:57:56 volumio volumio[1195]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 25 19:57:56 volumio sudo[1567]: pam_unix(sudo:session): session closed for user root Nov 25 19:57:56 volumio volumio[1195]: info: Remote SSH Stopped Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 19:57:56 volumio volumio[1195]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 19:57:56 volumio volumio[1195]: info: Setting Geolocation for MyVolumio to eu4 Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 19:57:56 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 25 19:57:57 volumio volumio[1195]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 25 19:57:57 volumio volumio[1195]: info: Updating MyVolumio device info Nov 25 19:57:57 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:57:58 volumio sudo[1580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kuzaru,password=NeKuRu125,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.1/media\\MUSIC /mnt/NAS/kuz Nov 25 19:57:58 volumio sudo[1580]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:57:58 volumio kernel: CIFS: Attempting to mount //192.168.1.1/media/MUSIC Nov 25 19:57:59 volumio volumio[1195]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 25 19:58:00 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 19:58:01 volumio volumio[1195]: info: MYVOLUMIO: Adding device Nov 25 19:58:01 volumio volumio[1195]: info: MYVOLUMIO: Evaluating Server Nov 25 19:58:02 volumio volumio[1195]: info: Setting Geolocation for MyVolumio to eu4 Nov 25 19:58:02 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:58:03 volumio volumio[1195]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Nov 25 19:58:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 25 19:58:03 volumio volumio[1195]: info: Updating MyVolumio device info Nov 25 19:58:03 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:58:03 volumio ntpd[808]: Soliciting pool server 151.0.2.54 Nov 25 19:58:03 volumio ntpd[808]: Soliciting pool server 162.159.200.123 Nov 25 19:58:04 volumio volumio[1195]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Nov 25 19:58:04 volumio ntpd[808]: Soliciting pool server 162.159.200.1 Nov 25 19:58:04 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 19:58:05 volumio ntpd[808]: Soliciting pool server 95.163.215.213 Nov 25 19:58:05 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 25 19:58:05 volumio volumio[1195]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 25 19:58:05 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:58:05 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:58:06 volumio ntpd[808]: Soliciting pool server 93.183.81.140 Nov 25 19:58:06 volumio ntpd[808]: Soliciting pool server 77.37.134.150 Nov 25 19:58:06 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Nov 25 19:58:07 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:58:07 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:58:07 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 25 19:58:07 volumio volumio-remote-updater[642]: No test mode Nov 25 19:58:07 volumio volumio-remote-updater[642]: No alpha test mode Nov 25 19:58:07 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 25 19:58:07 volumio volumio[1195]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 25 19:58:07 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 25 19:58:07 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 25 19:58:08 volumio sudo[1580]: pam_unix(sudo:session): session closed for user root Nov 25 19:58:08 volumio volumio[1195]: info: Cannot mount NAS kuz at system boot, trial number 3 ,retrying in 5 seconds Nov 25 19:58:08 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Nov 25 19:58:08 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Nov 25 19:58:08 volumio ntpd[808]: Soliciting pool server 213.234.203.30 Nov 25 19:58:08 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 19:58:09 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 25 19:58:09 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 25 19:58:09 volumio ntpd[808]: Soliciting pool server 51.250.110.169 Nov 25 19:58:10 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:58:10 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:58:10 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 25 19:58:10 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 25 19:58:10 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 25 19:58:10 volumio volumio[1195]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 19:58:10 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:58:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 25 19:58:11 volumio volumio[1195]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 25 19:58:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 25 19:58:11 volumio volumio[1195]: info: Received Get System Version Nov 25 19:58:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:58:11 volumio volumio[1195]: info: Received Get System Info Nov 25 19:58:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 19:58:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 19:58:11 volumio volumio[1195]: info: Discovery: Getting this device information Nov 25 19:58:11 volumio volumio[1195]: info: CoreCommandRouter::volumioGetState Nov 25 19:58:11 volumio volumio[1195]: info: CorePlayQueue::getTrack 0 Nov 25 19:58:11 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:58:14 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 25 19:58:14 volumio volumio[1195]: error: MyVolumio Plugin failed to authenticate in a timely fashion Nov 25 19:58:14 volumio volumio[1195]: info: Completed starting MyVolumio Plugin Nov 25 19:58:14 volumio volumio[1195]: [Metrics] CommandRouter: 51s 291.40ms Nov 25 19:58:14 volumio volumio[1195]: info: CoreCommandRouter::volumiosetStartupVolume Nov 25 19:58:14 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:58:14 volumio volumio[1195]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:58:14 volumio volumio[1195]: info: CoreCommandRouter::Close All Modals sent Nov 25 19:58:14 volumio volumio[1195]: info: CoreCommandRouter::Close All Modals sent Nov 25 19:58:14 volumio volumio[1368]: ............................................................................................................................++++ Nov 25 19:58:14 volumio volumio[1195]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 19:58:14 volumio volumio[1368]: e is 65537 (0x010001) Nov 25 19:58:14 volumio volumio[1195]: TypeError: Cannot read property 'replace' of undefined Nov 25 19:58:14 volumio volumio[1195]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Nov 25 19:58:14 volumio volumio[1195]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Nov 25 19:58:14 volumio volumio[1195]: at listOnTimeout (internal/timers.js:554:17) Nov 25 19:58:14 volumio volumio[1195]: at processTimers (internal/timers.js:497:7) Nov 25 19:58:14 volumio volumio[1195]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 19:58:14 volumio volumio[1368]: writing RSA key Nov 25 19:58:15 volumio sudo[1667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 19:57 Nov 25 19:58:15 volumio sudo[1667]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"