-- Logs begin at Sun 2024-09-15 23:32:45 +06, end at Sun 2024-09-15 23:34:06 +06. -- Sep 15 23:33:00 volumio-dacha bthelper[595]: Changing power off succeeded Sep 15 23:33:00 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:00] [info] asio async_connect error: system:111 (Connection refused) Sep 15 23:33:00 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 15 23:33:00 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:00] [error] handle_connect error: Underlying Transport Error Sep 15 23:33:00 volumio-dacha bthelper[595]: [CHG] Controller B8:27:EB:D2:AC:2C Class: 0x0000041c Sep 15 23:33:00 volumio-dacha bthelper[595]: Changing power on succeeded Sep 15 23:33:01 volumio-dacha ntpd[674]: Listen normally on 3 eth0 192.168.1.12:123 Sep 15 23:33:01 volumio-dacha ntpd[674]: new interface(s) found: waking up resolver Sep 15 23:33:01 volumio-dacha nmbd[618]: [2024/09/15 23:33:01.982938, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 15 23:33:01 volumio-dacha systemd[1]: Started Samba NMB Daemon. Sep 15 23:33:01 volumio-dacha nmbd[618]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 15 23:33:02 volumio-dacha systemd[1]: Starting Samba Winbind Daemon... Sep 15 23:33:02 volumio-dacha sudo[770]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:02 volumio-dacha wireless.js[544]: Start wireless flow Sep 15 23:33:02 volumio-dacha wireless.js[544]: Stopped hotspot (if there).. Sep 15 23:33:02 volumio-dacha sudo[784]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Sep 15 23:33:02 volumio-dacha sudo[784]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:02 volumio-dacha sudo[784]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:02 volumio-dacha sudo[786]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Sep 15 23:33:02 volumio-dacha sudo[786]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:02 volumio-dacha sudo[786]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:02 volumio-dacha winbindd[781]: [2024/09/15 23:33:02.746264, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Sep 15 23:33:02 volumio-dacha wireless.js[544]: DHCP IP Sep 15 23:33:02 volumio-dacha winbindd[781]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 15 23:33:02 volumio-dacha wireless.js[544]: Start ap Sep 15 23:33:02 volumio-dacha wpa_supplicant[788]: Successfully initialized wpa_supplicant Sep 15 23:33:02 volumio-dacha sudo[790]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Sep 15 23:33:02 volumio-dacha sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:02 volumio-dacha dhcpcd[791]: dev: loaded udev Sep 15 23:33:02 volumio-dacha kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 15 23:33:03 volumio-dacha dhcpcd-run-hooks[800]: wlan0: starting wpa_supplicant Sep 15 23:33:03 volumio-dacha winbindd[781]: [2024/09/15 23:33:03.728416, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 15 23:33:03 volumio-dacha winbindd[781]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 15 23:33:03 volumio-dacha systemd[1]: Started Samba Winbind Daemon. Sep 15 23:33:03 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:03 volumio-dacha systemd[1]: Starting Samba SMB Daemon... Sep 15 23:33:03 volumio-dacha sudo[806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:03 volumio-dacha sudo[806]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:04 volumio-dacha ntpd[674]: Soliciting pool server 195.218.227.230 Sep 15 23:33:04 volumio-dacha dhcpcd-run-hooks[810]: wlan0: failed to start wpa_supplicant Sep 15 23:33:04 volumio-dacha dhcpcd-run-hooks[811]: wlan0: Successfully initialized wpa_supplicant nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Match already configured nl80211: kernel reports: Ma Sep 15 23:33:04 volumio-dacha dhcpcd[791]: wlan0: connected to Access Point `' Sep 15 23:33:07 volumio-dacha sudo[806]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:07 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:07 volumio-dacha sudo[819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:07 volumio-dacha sudo[819]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:07 volumio-dacha sudo[819]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:07 volumio-dacha dhcpcd[791]: DUID 00:01:00:01:2d:69:1d:f8:b8:27:eb:78:06:86 Sep 15 23:33:07 volumio-dacha dhcpcd[791]: eth0: IAID eb:78:06:86 Sep 15 23:33:07 volumio-dacha dhcpcd[791]: eth0: adding address fe80::f32e:82a5:1538:d944 Sep 15 23:33:07 volumio-dacha dhcpcd[791]: ipv6_addaddr1: Permission denied Sep 15 23:33:07 volumio-dacha dhcpcd[791]: wlan0: waiting for carrier Sep 15 23:33:07 volumio-dacha dhcpcd[791]: eth0: soliciting an IPv6 router Sep 15 23:33:08 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:08] [info] asio async_connect error: system:111 (Connection refused) Sep 15 23:33:08 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 15 23:33:08 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:08] [error] handle_connect error: Underlying Transport Error Sep 15 23:33:08 volumio-dacha dhcpcd[791]: eth0: rebinding lease of 192.168.1.12 Sep 15 23:33:08 volumio-dacha dhcpcd[791]: eth0: leased 192.168.1.12 for 86400 seconds Sep 15 23:33:08 volumio-dacha dhcpcd[791]: eth0: adding route to 192.168.1.0/24 Sep 15 23:33:08 volumio-dacha dhcpcd[791]: eth0: adding default route via 192.168.1.1 Sep 15 23:33:08 volumio-dacha winbindd[781]: [2024/09/15 23:33:08.227179, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Sep 15 23:33:08 volumio-dacha winbindd[781]: res_names->count = 3, expected 4 Sep 15 23:33:08 volumio-dacha dhcpcd[791]: forked to background, child pid 857 Sep 15 23:33:08 volumio-dacha sudo[790]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:08 volumio-dacha smbd[820]: [2024/09/15 23:33:08.631603, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 15 23:33:08 volumio-dacha smbd[820]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 15 23:33:08 volumio-dacha systemd[1]: Started Samba SMB Daemon. Sep 15 23:33:08 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:08 volumio-dacha sudo[861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:08 volumio-dacha sudo[861]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:08 volumio-dacha sudo[861]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:09 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:09 volumio-dacha sudo[864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:09 volumio-dacha sudo[864]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:09 volumio-dacha sudo[864]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:10 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:10 volumio-dacha sudo[867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:10 volumio-dacha sudo[867]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:10 volumio-dacha sudo[867]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:11 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:11 volumio-dacha sudo[870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:11 volumio-dacha sudo[870]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:11 volumio-dacha sudo[870]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:12 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:12 volumio-dacha sudo[873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:12 volumio-dacha sudo[873]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:12 volumio-dacha sudo[873]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:13 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:13 volumio-dacha sudo[876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:13 volumio-dacha sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:13 volumio-dacha sudo[876]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:14 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:14 volumio-dacha sudo[879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:14 volumio-dacha sudo[879]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:14 volumio-dacha sudo[879]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:15 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:15 volumio-dacha sudo[882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:15 volumio-dacha sudo[882]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:15 volumio-dacha sudo[882]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:16 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:16 volumio-dacha sudo[885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:16 volumio-dacha sudo[885]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:16 volumio-dacha sudo[885]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:17 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:17 volumio-dacha sudo[888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:17 volumio-dacha sudo[888]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:17 volumio-dacha sudo[888]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:18 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:18] [info] asio async_connect error: system:111 (Connection refused) Sep 15 23:33:18 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:18] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 15 23:33:18 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:18] [error] handle_connect error: Underlying Transport Error Sep 15 23:33:18 volumio-dacha systemd[1]: systemd-fsckd.service: Succeeded. Sep 15 23:33:18 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:18 volumio-dacha sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:18 volumio-dacha sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:18 volumio-dacha sudo[891]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:19 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:19 volumio-dacha sudo[894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:19 volumio-dacha sudo[894]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:19 volumio-dacha sudo[894]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:20 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:20 volumio-dacha sudo[897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:20 volumio-dacha sudo[897]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:20 volumio-dacha sudo[897]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:21 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:21 volumio-dacha sudo[900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:21 volumio-dacha sudo[900]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:21 volumio-dacha sudo[900]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:22 volumio-dacha wpa_supplicant[809]: wlan0: Failed to initiate sched scan Sep 15 23:33:22 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:22 volumio-dacha sudo[903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:22 volumio-dacha sudo[903]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:22 volumio-dacha sudo[903]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:23 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:23 volumio-dacha sudo[906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:23 volumio-dacha sudo[906]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:23 volumio-dacha sudo[906]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:24 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:24 volumio-dacha sudo[909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:24 volumio-dacha sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:24 volumio-dacha sudo[909]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:25 volumio-dacha wireless.js[544]: trying... Sep 15 23:33:25 volumio-dacha sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 15 23:33:25 volumio-dacha sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:25 volumio-dacha sudo[912]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:26 volumio-dacha wireless.js[544]: Overtime, starting plan B Sep 15 23:33:26 volumio-dacha systemd[1]: systemd-hostnamed.service: Succeeded. Sep 15 23:33:26 volumio-dacha kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 15 23:33:26 volumio-dacha systemd[1]: Started Wireless Services. Sep 15 23:33:26 volumio-dacha systemd[1]: Started Volumio Backend Module. Sep 15 23:33:26 volumio-dacha systemd[1]: Started Volumio Cpu Tweaker. Sep 15 23:33:26 volumio-dacha systemd[1]: Reached target Multi-User System. Sep 15 23:33:26 volumio-dacha systemd[1]: Reached target Graphical Interface. Sep 15 23:33:26 volumio-dacha systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 15 23:33:27 volumio-dacha systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 15 23:33:27 volumio-dacha systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 15 23:33:27 volumio-dacha systemd[1]: Startup finished in 12.672s (kernel) + 44.165s (userspace) = 56.838s. Sep 15 23:33:27 volumio-dacha volumio-cpu-tweak[922]: Setting RT Priority for mpd Sep 15 23:33:27 volumio-dacha volumio-cpu-tweak[922]: pid 35's current scheduling policy: SCHED_OTHER Sep 15 23:33:27 volumio-dacha volumio-cpu-tweak[922]: pid 35's current scheduling priority: 0 Sep 15 23:33:27 volumio-dacha volumio-cpu-tweak[922]: Setting MPD Affinity Sep 15 23:33:27 volumio-dacha volumio-cpu-tweak[922]: pid 3's current affinity mask: f Sep 15 23:33:27 volumio-dacha volumio-cpu-tweak[922]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Sep 15 23:33:27 volumio-dacha volumio-cpu-tweak[922]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Sep 15 23:33:27 volumio-dacha systemd[1]: volumio_cpu_tweak.service: Succeeded. Sep 15 23:33:28 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:28] [info] asio async_connect error: system:111 (Connection refused) Sep 15 23:33:28 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:28] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Sep 15 23:33:28 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:28] [error] handle_connect error: Underlying Transport Error Sep 15 23:33:29 volumio-dacha volumio[921]: info: ------------------------------------------- Sep 15 23:33:29 volumio-dacha volumio[921]: info: ----- Volumio3 ---- Sep 15 23:33:29 volumio-dacha volumio[921]: info: ------------------------------------------- Sep 15 23:33:29 volumio-dacha volumio[921]: info: ----- System startup ---- Sep 15 23:33:29 volumio-dacha volumio[921]: info: ------------------------------------------- Sep 15 23:33:30 volumio-dacha wpa_supplicant[809]: wlan0: Failed to initiate sched scan Sep 15 23:33:30 volumio-dacha volumio[921]: info: MYVOLUMIO Environment detected Sep 15 23:33:30 volumio-dacha volumio[921]: info: Plugin folders cleanup Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning into folder /volumio/app/plugins/ Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning category audio_interface Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning category miscellanea Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning category music_service Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning category plugins.json Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning category system_controller Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning category user_interface Sep 15 23:33:30 volumio-dacha volumio[921]: info: Scanning into folder /data/plugins/ Sep 15 23:33:30 volumio-dacha volumio[921]: info: Plugin folders cleanup completed Sep 15 23:33:30 volumio-dacha volumio[921]: info: ------------------------------------------- Sep 15 23:33:30 volumio-dacha volumio[921]: info: ----- Core plugins startup ---- Sep 15 23:33:30 volumio-dacha volumio[921]: info: ------------------------------------------- Sep 15 23:33:30 volumio-dacha volumio[921]: info: Loading plugins from folder /volumio/app/plugins/ Sep 15 23:33:30 volumio-dacha volumio[921]: info: Adding plugin upnp to MyMusic Plugins Sep 15 23:33:30 volumio-dacha volumio[921]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 15 23:33:30 volumio-dacha volumio[921]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 15 23:33:30 volumio-dacha volumio[921]: info: Loading plugins from folder /data/plugins/ Sep 15 23:33:30 volumio-dacha volumio[921]: info: Loading plugin "system"... Sep 15 23:33:30 volumio-dacha volumio[921]: info: Loading plugin "appearance"... Sep 15 23:33:32 volumio-dacha volumio[921]: info: Loading plugin "network"... Sep 15 23:33:32 volumio-dacha volumio[921]: info: Refreshing Cached IP Addresses Sep 15 23:33:32 volumio-dacha sudo[953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 15 23:33:32 volumio-dacha sudo[953]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:32 volumio-dacha volumio[921]: info: Loading plugin "services"... Sep 15 23:33:32 volumio-dacha sudo[953]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:32 volumio-dacha sudo[955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 15 23:33:32 volumio-dacha sudo[955]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:32 volumio-dacha volumio[921]: info: Loading plugin "alsa_controller"... Sep 15 23:33:32 volumio-dacha sudo[955]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:32 volumio-dacha sudo[958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 15 23:33:32 volumio-dacha sudo[958]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:32 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 15 23:33:32 volumio-dacha volumio[921]: info: Loading plugin "wizard"... Sep 15 23:33:32 volumio-dacha volumio[921]: info: Loading plugin "networkfs"... Sep 15 23:33:32 volumio-dacha volumio[921]: info: Starting Udev Watcher for removable devices Sep 15 23:33:32 volumio-dacha volumio[921]: info: Ignoring mount for partition: boot Sep 15 23:33:32 volumio-dacha volumio[921]: info: Ignoring mount for partition: volumio Sep 15 23:33:32 volumio-dacha volumio[921]: info: Ignoring mount for partition: volumio_data Sep 15 23:33:32 volumio-dacha volumio[921]: info: Mounting Device Новый_том Sep 15 23:33:32 volumio-dacha sudo[967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Новый_том -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Sep 15 23:33:32 volumio-dacha sudo[967]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:32 volumio-dacha kernel: fuse: init (API version 7.37) Sep 15 23:33:32 volumio-dacha systemd[1]: Mounting FUSE Control File System... Sep 15 23:33:32 volumio-dacha systemd[1]: Mounted FUSE Control File System. Sep 15 23:33:33 volumio-dacha ntfs-3g[974]: Version 2017.3.23AR.3 integrated FUSE 28 Sep 15 23:33:33 volumio-dacha ntfs-3g[974]: Mounted /dev/sda1 (Read-Write, label "Новый том", NTFS 3.1) Sep 15 23:33:33 volumio-dacha ntfs-3g[974]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Sep 15 23:33:33 volumio-dacha ntfs-3g[974]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Sep 15 23:33:33 volumio-dacha ntfs-3g[974]: Global ownership and permissions enforced, configuration type 7 Sep 15 23:33:33 volumio-dacha sudo[967]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:33 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 15 23:33:33 volumio-dacha volumio[921]: info: Loading plugin "volumio_command_line_client"... Sep 15 23:33:33 volumio-dacha volumio[921]: info: Loading plugin "upnp"... Sep 15 23:33:33 volumio-dacha volumio[921]: info: [1726421613283] Starting Upmpd Daemon Sep 15 23:33:33 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 15 23:33:33 volumio-dacha volumio[921]: info: Loading plugin "my_music"... Sep 15 23:33:33 volumio-dacha volumio[921]: info: Loading plugin "mpd"... Sep 15 23:33:33 volumio-dacha volumio[921]: info: Loading plugin "upnp_browser"... Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "alarm-clock"... Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "airplay_emulation"... Sep 15 23:33:34 volumio-dacha volumio[921]: info: Starting Shairport Sync Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "last_100"... Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "webradio"... Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "i2s_dacs"... Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "volumiodiscovery"... Sep 15 23:33:34 volumio-dacha volumio[921]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 15 23:33:34 volumio-dacha volumio[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 15 23:33:34 volumio-dacha volumio[921]: *** WARNING *** For more information see Sep 15 23:33:34 volumio-dacha node[921]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 15 23:33:34 volumio-dacha volumio[921]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 15 23:33:34 volumio-dacha volumio[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 15 23:33:34 volumio-dacha volumio[921]: *** WARNING *** For more information see Sep 15 23:33:34 volumio-dacha node[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 15 23:33:34 volumio-dacha node[921]: *** WARNING *** For more information see Sep 15 23:33:34 volumio-dacha node[921]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 15 23:33:34 volumio-dacha node[921]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 15 23:33:34 volumio-dacha node[921]: *** WARNING *** For more information see Sep 15 23:33:34 volumio-dacha volumio[921]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 15 23:33:34 volumio-dacha volumio[921]: info: Discovery: Started advertising with name: Volumio dacha Sep 15 23:33:34 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "outputs"... Sep 15 23:33:34 volumio-dacha volumio[921]: info: Loading plugin "albumart"... Sep 15 23:33:35 volumio-dacha volumio[921]: info: Plugin example_plugin is not enabled Sep 15 23:33:35 volumio-dacha volumio[921]: info: Loading plugin "inputs"... Sep 15 23:33:35 volumio-dacha volumio[921]: info: Loading plugin "updater_comm"... Sep 15 23:33:35 volumio-dacha sudo[958]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:35 volumio-dacha volumio[921]: info: Plugin mpdemulation is not enabled Sep 15 23:33:35 volumio-dacha volumio[921]: info: Loading plugin "rest_api"... Sep 15 23:33:35 volumio-dacha volumio[921]: info: Loading plugin "websocket"... Sep 15 23:33:35 volumio-dacha volumio[921]: info: Loading i18n strings for locale ru Sep 15 23:33:35 volumio-dacha volumio[921]: Updating browse sources language Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 15 23:33:35 volumio-dacha volumio[921]: Forking 3 albumart workers Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::initPlayerControls Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: Express server listening on port 3000 Sep 15 23:33:35 volumio-dacha volumio[921]: [Metrics] WebUI: 7s 22.41ms Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::resetVolumioState Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::getcurrentVolume Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioRetrievevolume Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::pushState Sep 15 23:33:35 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioPushState Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::updateTrackBlock Sep 15 23:33:35 volumio-dacha volumio[921]: info: CorePlayQueue::getTrackBlock Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioRetrievevolume Sep 15 23:33:35 volumio-dacha volumio[921]: info: Reloading queue from file Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::setRepeat true single undefined Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::pushState Sep 15 23:33:35 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioPushState Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::setRandom true Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreStateMachine::pushState Sep 15 23:33:35 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 15 23:33:35 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioPushState Sep 15 23:33:35 volumio-dacha volumio[921]: info: Setting Device type: Raspberry PI Sep 15 23:33:36 volumio-dacha volumio[921]: info: CoreStateMachine::pushState Sep 15 23:33:36 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:36 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioPushState Sep 15 23:33:36 volumio-dacha volumio[921]: Starting albumart workers Sep 15 23:33:36 volumio-dacha volumio[921]: Starting albumart workers Sep 15 23:33:36 volumio-dacha volumio[921]: Starting albumart workers Sep 15 23:33:37 volumio-dacha wpa_supplicant[809]: wlan0: Failed to initiate sched scan Sep 15 23:33:38 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:38] [connect] Successful connection Sep 15 23:33:38 volumio-dacha volumio-remote-updater[540]: [2024-09-15 23:33:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1726421618 101 Sep 15 23:33:38 volumio-dacha volumio[921]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Sep 15 23:33:43 volumio-dacha sudo[1050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 15 23:33:43 volumio-dacha sudo[1050]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:43 volumio-dacha sudo[1050]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:43 volumio-dacha sudo[1052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 15 23:33:43 volumio-dacha sudo[1052]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:43 volumio-dacha sudo[1052]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:43 volumio-dacha sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 15 23:33:43 volumio-dacha sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:43 volumio-dacha systemd[1]: Started UPnP Renderer front-end to MPD. Sep 15 23:33:43 volumio-dacha sudo[1056]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:43 volumio-dacha volumio[921]: info: Upmpdcli Daemon Started Sep 15 23:33:43 volumio-dacha volumio[921]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 15 23:33:45 volumio-dacha wpa_supplicant[809]: wlan0: Failed to initiate sched scan Sep 15 23:33:46 volumio-dacha volumio[921]: info: Discovery: adding bcddd5d2-0151-4aaa-9766-f5f12c66a46e Sep 15 23:33:46 volumio-dacha volumio[921]: info: Discovery: Found device Volumio dacha Sep 15 23:33:46 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:33:46 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:47 volumio-dacha volumio[921]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 15 23:33:53 volumio-dacha volumio[921]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 15 23:33:53 volumio-dacha wpa_supplicant[809]: wlan0: Failed to initiate sched scan Sep 15 23:33:54 volumio-dacha volumiologrotate[546]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Sep 15 23:33:54 volumio-dacha volumiologrotate[546]: ls: cannot access 'DACHA': No such file or directory Sep 15 23:33:54 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 15 23:33:54 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 15 23:33:54 volumio-dacha volumio[921]: info: Discovery: Getting this device information Sep 15 23:33:54 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:33:54 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:54 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 15 23:33:54 volumio-dacha volumio[921]: verbose: New Socket.io Connection to 192.168.1.12:3000 from 192.168.1.7 UA: Dart/3.4 (dart:io) Total Clients: 2 Sep 15 23:33:54 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:33:54 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:54 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Sep 15 23:33:54 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Sep 15 23:33:58 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 15 23:33:58 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 15 23:33:58 volumio-dacha volumio[921]: info: Discovery: Getting this device information Sep 15 23:33:58 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:33:58 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:58 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 15 23:33:58 volumio-dacha sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 15 23:33:58 volumio-dacha sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:58 volumio-dacha sudo[1098]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:58 volumio-dacha sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 15 23:33:58 volumio-dacha sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:58 volumio-dacha sudo[1100]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:58 volumio-dacha volumio[921]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.7 UA: Mozilla/5.0 (Linux; Android 13; TFY-LX1 Build/HONORTFY-L31CQ; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.100 Mobile Safari/537.36 Total Clients: 3 Sep 15 23:33:59 volumio-dacha sudo[1104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 15 23:33:59 volumio-dacha sudo[1104]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:59 volumio-dacha sudo[1104]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:59 volumio-dacha sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 15 23:33:59 volumio-dacha sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:33:59 volumio-dacha sudo[1106]: pam_unix(sudo:session): session closed for user root Sep 15 23:33:59 volumio-dacha volumio[921]: verbose: New Socket.io Connection to 192.168.1.12 from 192.168.1.7 UA: Mozilla/5.0 (Linux; Android 13; TFY-LX1 Build/HONORTFY-L31CQ; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.100 Mobile Safari/537.36 Total Clients: 4 Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetVisibleSources Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:33:59 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetQueue Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreStateMachine::getQueue Sep 15 23:33:59 volumio-dacha volumio[921]: info: CorePlayQueue::getQueue Sep 15 23:33:59 volumio-dacha volumio[921]: info: Listing playlists Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 15 23:33:59 volumio-dacha volumio[921]: info: Received Get System Info Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 15 23:33:59 volumio-dacha volumio[921]: info: Discovery: Getting this device information Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:33:59 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:33:59 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 15 23:33:59 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 15 23:34:01 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 15 23:34:01 volumio-dacha volumio[921]: info: Received Get System Info Sep 15 23:34:01 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 15 23:34:01 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 15 23:34:01 volumio-dacha volumio[921]: info: Discovery: Getting this device information Sep 15 23:34:01 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:34:01 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:34:01 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 15 23:34:01 volumio-dacha wpa_supplicant[809]: wlan0: Failed to initiate sched scan Sep 15 23:34:03 volumio-dacha volumio[921]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Sep 15 23:34:04 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 15 23:34:04 volumio-dacha volumio[921]: info: Received Get System Info Sep 15 23:34:04 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 15 23:34:04 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 15 23:34:04 volumio-dacha volumio[921]: info: Discovery: Getting this device information Sep 15 23:34:04 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioGetState Sep 15 23:34:04 volumio-dacha volumio[921]: info: CorePlayQueue::getTrack 0 Sep 15 23:34:04 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 15 23:34:05 volumio-dacha volumio[921]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Sep 15 23:34:05 volumio-dacha volumio[921]: info: Preparing to generate the ALSA configuration file Sep 15 23:34:05 volumio-dacha volumio[921]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 15 23:34:05 volumio-dacha volumio[921]: info: Reading ALSA contributions from plugins. Sep 15 23:34:05 volumio-dacha volumio[921]: info: Asound.conf file unchanged, so no further update is needed Sep 15 23:34:05 volumio-dacha volumio[921]: info: Output device has changed, restarting MPD Sep 15 23:34:05 volumio-dacha volumio[921]: info: Output device has changed, restarting Shairport Sync Sep 15 23:34:05 volumio-dacha sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 15 23:34:05 volumio-dacha sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:34:05 volumio-dacha sudo[1110]: pam_unix(sudo:session): session closed for user root Sep 15 23:34:05 volumio-dacha sudo[1112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 15 23:34:05 volumio-dacha sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:34:05 volumio-dacha volumio[921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 15 23:34:05 volumio-dacha volumio[921]: info: ___________ START PLUGINS ___________ Sep 15 23:34:05 volumio-dacha volumio[921]: info: ControllerMpd::onStart: Initializing MPD Sep 15 23:34:05 volumio-dacha volumio[921]: info: Creating MPD Configuration file Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 15 23:34:05 volumio-dacha sudo[1120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 15 23:34:05 volumio-dacha sudo[1120]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:34:05 volumio-dacha volumio[921]: info: [1726421645431] CoreMusicLibrary::Adding element Медиа-серверы Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 15 23:34:05 volumio-dacha sudo[1120]: pam_unix(sudo:session): session closed for user root Sep 15 23:34:05 volumio-dacha systemd[1]: Listening on mpd.socket. Sep 15 23:34:05 volumio-dacha sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 15 23:34:05 volumio-dacha systemd[1]: Starting Music Player Daemon... Sep 15 23:34:05 volumio-dacha sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 15 23:34:05 volumio-dacha systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Sep 15 23:34:05 volumio-dacha systemd[1]: mpd.service: Succeeded. Sep 15 23:34:05 volumio-dacha systemd[1]: Stopped Music Player Daemon. Sep 15 23:34:05 volumio-dacha systemd[1]: Starting Music Player Daemon... Sep 15 23:34:05 volumio-dacha volumio[921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 15 23:34:05 volumio-dacha volumio[921]: info: [1726421645566] CoreMusicLibrary::Adding element Last_100 Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 15 23:34:05 volumio-dacha volumio[921]: info: [1726421645571] CoreMusicLibrary::Adding element Webradio Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 15 23:34:05 volumio-dacha volumio[921]: info: Volumio Calling Home Sep 15 23:34:05 volumio-dacha volumio[921]: info: MPD Permissions set Sep 15 23:34:05 volumio-dacha volumio[921]: info: MPD Permissions set Sep 15 23:34:05 volumio-dacha volumio[921]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 15 23:34:05 volumio-dacha volumio[921]: info: Starting Shairport Sync Sep 15 23:34:05 volumio-dacha volumio[921]: info: Starting Shairport Sync Sep 15 23:34:05 volumio-dacha volumio[921]: info: Starting Shairport Sync Sep 15 23:34:06 volumio-dacha volumio[921]: info: Preload queue cleared Sep 15 23:34:06 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 15 23:34:06 volumio-dacha volumio[921]: info: CoreStateMachine::ClearQueue Sep 15 23:34:06 volumio-dacha volumio[921]: info: CoreStateMachine::stop Sep 15 23:34:06 volumio-dacha volumio[921]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 15 23:34:06 volumio-dacha sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 15 23:34:06 volumio-dacha volumio[921]: info: CorePlayQueue::clearPlayQueue Sep 15 23:34:06 volumio-dacha volumio[921]: info: CorePlayQueue::saveQueue Sep 15 23:34:06 volumio-dacha volumio[921]: info: CoreCommandRouter::volumioPushQueue Sep 15 23:34:06 volumio-dacha sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 15 23:34:06 volumio-dacha ntpd[674]: Soliciting pool server 194.190.168.1 Sep 15 23:34:06 volumio-dacha sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:34:06 volumio-dacha sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:34:06 volumio-dacha sudo[1149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 15 23:34:06 volumio-dacha sudo[1149]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 15 23:34:06 volumio-dacha volumio[921]: info: CoreStateMachine::addQueueItems Sep 15 23:34:06 volumio-dacha volumio[921]: info: CorePlayQueue::addQueueItems Sep 15 23:34:06 volumio-dacha volumio[921]: info: Preload queue cleared Sep 15 23:34:06 volumio-dacha volumio[921]: info: Adding Item to queue: music-library/USB/Новый_том/Picnik/Пикник - 35 - Лучшее и неизданное (2016)/Пикник - 35 - «Неизданное» (CD2).flac Sep 15 23:34:06 volumio-dacha volumio[921]: info: Exploding uri music-library/USB/Новый_том/Picnik/Пикник - 35 - Лучшее и неизданное (2016)/Пикник - 35 - «Неизданное» (CD2).flac in service mpd Sep 15 23:34:06 volumio-dacha volumio[921]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 15 23:34:06 volumio-dacha volumio[921]: TypeError: Cannot read property 'then' of undefined Sep 15 23:34:06 volumio-dacha volumio[921]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Sep 15 23:34:06 volumio-dacha volumio[921]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Sep 15 23:34:06 volumio-dacha volumio[921]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1359:16) Sep 15 23:34:06 volumio-dacha volumio[921]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Sep 15 23:34:06 volumio-dacha volumio[921]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Sep 15 23:34:06 volumio-dacha volumio[921]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Sep 15 23:34:06 volumio-dacha volumio[921]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Sep 15 23:34:06 volumio-dacha volumio[921]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Sep 15 23:34:06 volumio-dacha volumio[921]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:477:17) Sep 15 23:34:06 volumio-dacha volumio[921]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:118:33) Sep 15 23:34:06 volumio-dacha volumio[921]: at Socket.emit (events.js:315:20) Sep 15 23:34:06 volumio-dacha volumio[921]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Sep 15 23:34:06 volumio-dacha volumio[921]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Sep 15 23:34:06 volumio-dacha volumio[921]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 15 23:34:06 volumio-dacha systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 15 23:34:06 volumio-dacha systemd[1]: shairport-sync.service: Succeeded. Sep 15 23:34:06 volumio-dacha systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 15 23:34:06 volumio-dacha systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 15 23:34:06 volumio-dacha sudo[1145]: pam_unix(sudo:session): session closed for user root Sep 15 23:34:06 volumio-dacha sudo[1149]: pam_unix(sudo:session): session closed for user root Sep 15 23:34:06 volumio-dacha sudo[1147]: pam_unix(sudo:session): session closed for user root Sep 15 23:34:06 volumio-dacha sudo[1165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-15 23:33 Sep 15 23:34:06 volumio-dacha sudo[1165]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"