-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Fri 2025-03-14 18:46:20 +07. -- Mar 14 18:45:00 volumio-pi5 volumio[2828]: info: Get:9 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libmpc3 armhf 1.1.0-1 [32.1 kB] Mar 14 18:45:00 volumio-pi5 volumio[2828]: info: Get:10 http://mirror.as43289.net/raspbian/raspbian buster/main armhf cpp-8 armhf 8.3.0-6+rpi1 [6787 kB] Mar 14 18:45:05 volumio-pi5 volumio[2828]: info: Get:11 http://mirror.as43289.net/raspbian/raspbian buster/main armhf cpp armhf 4:8.3.0-1+rpi2 [19.6 kB] Mar 14 18:45:05 volumio-pi5 volumio[2828]: info: Get:12 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libglu1-mesa armhf 9.0.0-2.1 [130 kB] Mar 14 18:45:05 volumio-pi5 volumio[2828]: info: Get:13 http://mirror.as43289.net/raspbian/raspbian buster/main armhf x11-apps armhf 7.7+7 [541 kB] Mar 14 18:45:05 volumio-pi5 volumio[2828]: info: Get:14 http://mirror.as43289.net/raspbian/raspbian buster/main armhf x11-session-utils armhf 7.7+3 [61.2 kB] Mar 14 18:45:06 volumio-pi5 volumio[2828]: info: Get:15 http://mirror.as43289.net/raspbian/raspbian buster/main armhf xfonts-100dpi all 1:1.0.4+nmu1 [3822 kB] Mar 14 18:45:07 volumio-pi5 volumio[2828]: info: Get:16 http://mirror.as43289.net/raspbian/raspbian buster/main armhf xfonts-75dpi all 1:1.0.4+nmu1 [3367 kB] Mar 14 18:45:07 volumio-pi5 volumio[2828]: info: Get:17 http://mirror.as43289.net/raspbian/raspbian buster/main armhf xfonts-scalable all 1:1.0.3-1.1 [304 kB] Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Get:18 http://mirror.as43289.net/raspbian/raspbian buster/main armhf xorg-docs-core all 1:1.7.1-1.1 [84.0 kB] Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Get:19 http://mirror.as43289.net/raspbian/raspbian buster/main armhf xorg armhf 1:7.7+19+b8 [38.8 kB] Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Fetched 18.8 MB in 12s (1618 kB/s) Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Selecting previously unselected package bsdmainutils. Mar 14 18:45:08 volumio-pi5 volumio[2828]: [620B blob data] Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Preparing to unpack .../00-bsdmainutils_11.1.2_armhf.deb ... Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Unpacking bsdmainutils (11.1.2) ... Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Selecting previously unselected package libuchardet0:armhf. Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Preparing to unpack .../01-libuchardet0_0.0.6-3_armhf.deb ... Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Unpacking libuchardet0:armhf (0.0.6-3) ... Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Selecting previously unselected package groff-base. Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Preparing to unpack .../02-groff-base_1.22.4-3+deb10u1_armhf.deb ... Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Unpacking groff-base (1.22.4-3+deb10u1) ... Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Selecting previously unselected package libpipeline1:armhf. Mar 14 18:45:08 volumio-pi5 volumio[2828]: info: Preparing to unpack .../03-libpipeline1_1.5.1-2_armhf.deb ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Unpacking libpipeline1:armhf (1.5.1-2) ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Selecting previously unselected package man-db. Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Preparing to unpack .../04-man-db_2.8.5-2+deb10u1_armhf.deb ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Unpacking man-db (2.8.5-2+deb10u1) ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Selecting previously unselected package libisl19:armhf. Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Preparing to unpack .../05-libisl19_0.20-2_armhf.deb ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Unpacking libisl19:armhf (0.20-2) ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Selecting previously unselected package libmpfr6:armhf. Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Preparing to unpack .../06-libmpfr6_4.0.2-1_armhf.deb ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Unpacking libmpfr6:armhf (4.0.2-1) ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Selecting previously unselected package libmpc3:armhf. Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Preparing to unpack .../07-libmpc3_1.1.0-1_armhf.deb ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Unpacking libmpc3:armhf (1.1.0-1) ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Selecting previously unselected package cpp-8. Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Preparing to unpack .../08-cpp-8_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:45:09 volumio-pi5 volumio[2828]: info: Unpacking cpp-8 (8.3.0-6+rpi1) ... Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Selecting previously unselected package cpp. Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Preparing to unpack .../09-cpp_4%3a8.3.0-1+rpi2_armhf.deb ... Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Unpacking cpp (4:8.3.0-1+rpi2) ... Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Selecting previously unselected package libglu1-mesa:armhf. Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Preparing to unpack .../10-libglu1-mesa_9.0.0-2.1_armhf.deb ... Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Unpacking libglu1-mesa:armhf (9.0.0-2.1) ... Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Selecting previously unselected package x11-apps. Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Preparing to unpack .../11-x11-apps_7.7+7_armhf.deb ... Mar 14 18:45:10 volumio-pi5 volumio[2828]: info: Unpacking x11-apps (7.7+7) ... Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Selecting previously unselected package x11-session-utils. Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Preparing to unpack .../12-x11-session-utils_7.7+3_armhf.deb ... Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Unpacking x11-session-utils (7.7+3) ... Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Selecting previously unselected package x11-xserver-utils. Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Preparing to unpack .../13-x11-xserver-utils_7.7+8+rpt1_armhf.deb ... Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Unpacking x11-xserver-utils (7.7+8+rpt1) ... Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Selecting previously unselected package xfonts-100dpi. Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Preparing to unpack .../14-xfonts-100dpi_1%3a1.0.4+nmu1_all.deb ... Mar 14 18:45:11 volumio-pi5 volumio[2828]: info: Unpacking xfonts-100dpi (1:1.0.4+nmu1) ... Mar 14 18:45:12 volumio-pi5 volumio[2828]: info: Selecting previously unselected package xfonts-75dpi. Mar 14 18:45:12 volumio-pi5 volumio[2828]: info: Preparing to unpack .../15-xfonts-75dpi_1%3a1.0.4+nmu1_all.deb ... Mar 14 18:45:12 volumio-pi5 volumio[2828]: info: Unpacking xfonts-75dpi (1:1.0.4+nmu1) ... Mar 14 18:45:13 volumio-pi5 volumio[2828]: info: Selecting previously unselected package xfonts-scalable. Mar 14 18:45:13 volumio-pi5 volumio[2828]: info: Preparing to unpack .../16-xfonts-scalable_1%3a1.0.3-1.1_all.deb ... Mar 14 18:45:13 volumio-pi5 volumio[2828]: info: Unpacking xfonts-scalable (1:1.0.3-1.1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Selecting previously unselected package xorg-docs-core. Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Preparing to unpack .../17-xorg-docs-core_1%3a1.7.1-1.1_all.deb ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Unpacking xorg-docs-core (1:1.7.1-1.1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Selecting previously unselected package xorg. Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Preparing to unpack .../18-xorg_1%3a7.7+19+b8_armhf.deb ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Unpacking xorg (1:7.7+19+b8) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up libpipeline1:armhf (1.5.1-2) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up xfonts-100dpi (1:1.0.4+nmu1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up xorg-docs-core (1:1.7.1-1.1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up libmpfr6:armhf (4.0.2-1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up bsdmainutils (11.1.2) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: update-alternatives: using /usr/bin/bsd-write to provide /usr/bin/write (write) in auto mode Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: update-alternatives: using /usr/bin/bsd-from to provide /usr/bin/from (from) in auto mode Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up libmpc3:armhf (1.1.0-1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up libisl19:armhf (0.20-2) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up libuchardet0:armhf (0.0.6-3) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up libglu1-mesa:armhf (9.0.0-2.1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up xfonts-75dpi (1:1.0.4+nmu1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up cpp-8 (8.3.0-6+rpi1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up xfonts-scalable (1:1.0.3-1.1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up groff-base (1.22.4-3+deb10u1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up cpp (4:8.3.0-1+rpi2) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up x11-session-utils (7.7+3) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up x11-xserver-utils (7.7+8+rpt1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Setting up man-db (2.8.5-2+deb10u1) ... Mar 14 18:45:14 volumio-pi5 volumio[2828]: info: Building database of manual pages ... Mar 14 18:45:15 volumio-pi5 systemd[1]: Reloading. Mar 14 18:45:15 volumio-pi5 volumio[2828]: info: Created symlink /etc/systemd/system/timers.target.wants/man-db.timer → /lib/systemd/system/man-db.timer. Mar 14 18:45:15 volumio-pi5 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 14 18:45:15 volumio-pi5 systemd[1]: Reloading. Mar 14 18:45:15 volumio-pi5 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 14 18:45:15 volumio-pi5 volumio[2828]: info: man-db.service is a disabled or a static unit, not starting it. Mar 14 18:45:15 volumio-pi5 systemd[1]: Started Daily man-db regeneration. Mar 14 18:45:15 volumio-pi5 volumio[2828]: info: Setting up x11-apps (7.7+7) ... Mar 14 18:45:16 volumio-pi5 volumio[2828]: info: Setting up xorg (1:7.7+19+b8) ... Mar 14 18:45:16 volumio-pi5 volumio[2828]: info: Processing triggers for mime-support (3.62) ... Mar 14 18:45:16 volumio-pi5 volumio[2828]: info: Processing triggers for libc-bin (2.28-10+rpt2+rpi1+deb10u2) ... Mar 14 18:45:16 volumio-pi5 volumio[2828]: info: Processing triggers for fontconfig (2.13.1-2) ... Mar 14 18:45:16 volumio-pi5 volumio[2828]: info: Reading package lists... Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: Building dependency tree... Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: Reading state information... Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: The following additional packages will be installed: Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: adwaita-icon-theme at-spi2-core dconf-gsettings-backend dconf-service Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: giblib1 glib-networking glib-networking-common glib-networking-services Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: gnome-icon-theme gsettings-desktop-schemas gtk-update-icon-cache Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: hicolor-icon-theme libatk-bridge2.0-0 libatk1.0-0 libatk1.0-data Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libatspi2.0-0 libcairo-gobject2 libcolord2 libdconf1 libgail-common Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libgail18 libgif7 libgtk-3-0 libgtk-3-bin libgtk-3-common libgtk2.0-0 Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libgtk2.0-bin libgtk2.0-common libimlib2 libjson-glib-1.0-0 Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libjson-glib-1.0-common liblcms2-2 libobrender32v5 libobt2v5 Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libpangoxft-1.0-0 libproxy1v5 librest-0.7-0 librsvg2-common Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libsoup-gnome2.4-1 libsoup2.4-1 libstartup-notification0 libxcb-util0 obconf Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: obsession scrot Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: Suggested packages: Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: colord gvfs liblcms2-utils fonts-dejavu libxml2-dev tint2 Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: openbox-gnome-session openbox-kde-session Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: The following NEW packages will be installed: Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: adwaita-icon-theme at-spi2-core dconf-gsettings-backend dconf-service Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: giblib1 glib-networking glib-networking-common glib-networking-services Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: gnome-icon-theme gsettings-desktop-schemas gtk-update-icon-cache Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: hicolor-icon-theme libatk-bridge2.0-0 libatk1.0-0 libatk1.0-data Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libatspi2.0-0 libcairo-gobject2 libcolord2 libdconf1 libgail-common Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libgail18 libgif7 libgtk-3-0 libgtk-3-bin libgtk-3-common libgtk2.0-0 Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libgtk2.0-bin libgtk2.0-common libimlib2 libjson-glib-1.0-0 Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libjson-glib-1.0-common liblcms2-2 libobrender32v5 libobt2v5 Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libpangoxft-1.0-0 libproxy1v5 librest-0.7-0 librsvg2-common Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: libsoup-gnome2.4-1 libsoup2.4-1 libstartup-notification0 libxcb-util0 obconf Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: obsession openbox scrot Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: 0 upgraded, 46 newly installed, 0 to remove and 2 not upgraded. Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: Need to get 34.9 MB of archives. Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: After this operation, 116 MB of additional disk space will be used. Mar 14 18:45:17 volumio-pi5 volumio[2828]: info: Get:1 http://archive.raspberrypi.org/debian buster/main armhf gtk-update-icon-cache armhf 3.24.5-1+rpt2 [80.5 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:3 http://archive.raspberrypi.org/debian buster/main armhf libcairo-gobject2 armhf 1.16.0-4+rpt1+deb10u1 [124 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:5 http://archive.raspberrypi.org/debian buster/main armhf libgtk2.0-common all 2.24.32-3+rpt1 [2698 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:2 http://mirror.as43289.net/raspbian/raspbian buster/main armhf hicolor-icon-theme all 0.17-2 [11.4 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:4 http://mirror.as43289.net/raspbian/raspbian buster/main armhf librsvg2-common armhf 2.44.10-2.1+rpi1+deb10u3 [23.3 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:7 http://archive.raspberrypi.org/debian buster/main armhf libgtk2.0-0 armhf 2.24.32-3+rpt1 [1500 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:8 http://archive.raspberrypi.org/debian buster/main armhf libgail18 armhf 2.24.32-3+rpt1 [53.5 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:9 http://archive.raspberrypi.org/debian buster/main armhf libgail-common armhf 2.24.32-3+rpt1 [128 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:10 http://archive.raspberrypi.org/debian buster/main armhf libgtk-3-common all 3.24.5-1+rpt2 [3680 kB] Mar 14 18:45:18 volumio-pi5 volumio[2828]: info: Get:6 http://mirror.as43289.net/raspbian/raspbian buster/main armhf adwaita-icon-theme all 3.30.1-1 [11.7 MB] Mar 14 18:45:19 volumio-pi5 volumio[2828]: info: Get:12 http://archive.raspberrypi.org/debian buster/main armhf libgtk-3-0 armhf 3.24.5-1+rpt2 [2136 kB] Mar 14 18:45:19 volumio-pi5 volumio[2828]: info: Get:13 http://archive.raspberrypi.org/debian buster/main armhf libgtk-3-bin armhf 3.24.5-1+rpt2 [111 kB] Mar 14 18:45:19 volumio-pi5 volumio[2828]: info: Get:14 http://archive.raspberrypi.org/debian buster/main armhf libgtk2.0-bin armhf 2.24.32-3+rpt1 [48.6 kB] Mar 14 18:45:19 volumio-pi5 volumio[2828]: info: Get:15 http://archive.raspberrypi.org/debian buster/main armhf libobt2v5 armhf 3.6.1-8+rpt5 [62.7 kB] Mar 14 18:45:19 volumio-pi5 volumio[2828]: info: Get:16 http://archive.raspberrypi.org/debian buster/main armhf libobrender32v5 armhf 3.6.1-8+rpt5 [70.3 kB] Mar 14 18:45:19 volumio-pi5 volumio[2828]: info: Get:17 http://archive.raspberrypi.org/debian buster/main armhf obconf armhf 1:2.0.4+git20150213-2+rpt4 [125 kB] Mar 14 18:45:19 volumio-pi5 volumio[2828]: info: Get:18 http://archive.raspberrypi.org/debian buster/main armhf openbox armhf 3.6.1-8+rpt5 [289 kB] Mar 14 18:45:20 volumio-pi5 volumio[2828]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 18:45:20 volumio-pi5 volumio[2828]: Error: connect ETIMEDOUT 151.101.38.79:80 Mar 14 18:45:20 volumio-pi5 volumio[2828]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 14 18:45:20 volumio-pi5 volumio[2828]: errno: -110, Mar 14 18:45:20 volumio-pi5 volumio[2828]: code: 'ETIMEDOUT', Mar 14 18:45:20 volumio-pi5 volumio[2828]: syscall: 'connect', Mar 14 18:45:20 volumio-pi5 volumio[2828]: address: '151.101.38.79', Mar 14 18:45:20 volumio-pi5 volumio[2828]: port: 80 Mar 14 18:45:20 volumio-pi5 volumio[2828]: } Mar 14 18:45:20 volumio-pi5 volumio[2828]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 18:45:20 volumio-pi5 sudo[5876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-14 18:44 Mar 14 18:45:20 volumio-pi5 sudo[5876]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:20 volumio-pi5 sudo[5876]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:20 volumio-pi5 volumio-remote-updater[799]: [2025-03-14 11:45:20] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 14 18:45:20 volumio-pi5 volumio-remote-updater[799]: [2025-03-14 11:45:20] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 14 18:45:20 volumio-pi5 systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 14 18:45:20 volumio-pi5 sudo[3909]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:21 volumio-pi5 systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 14 18:45:21 volumio-pi5 systemd[1]: Started dynamicswap service. Mar 14 18:45:21 volumio-pi5 systemd[1]: dynamicswap.service: Succeeded. Mar 14 18:45:21 volumio-pi5 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 14 18:45:21 volumio-pi5 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Mar 14 18:45:21 volumio-pi5 systemd[1]: Stopped Volumio Backend Module. Mar 14 18:45:21 volumio-pi5 systemd[1]: Started Volumio Backend Module. Mar 14 18:45:21 volumio-pi5 systemd[1]: Started dynamicswap service. Mar 14 18:45:21 volumio-pi5 systemd[1]: dynamicswap.service: Succeeded. Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ------------------------------------------- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ----- Volumio3 ---- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ------------------------------------------- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ----- System startup ---- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ------------------------------------------- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: MYVOLUMIO Environment detected Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Plugin folders cleanup Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning into folder /volumio/app/plugins/ Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning category audio_interface Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning category miscellanea Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning category music_service Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning category plugins.json Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning category system_controller Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning category user_interface Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning into folder /data/plugins/ Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Scanning category user_interface Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Plugin folders cleanup completed Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ------------------------------------------- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ----- Core plugins startup ---- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: ------------------------------------------- Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Loading plugins from folder /volumio/app/plugins/ Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Adding plugin upnp to MyMusic Plugins Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Loading plugins from folder /data/plugins/ Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Loading plugin "system"... Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Loading plugin "appearance"... Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Loading plugin "network"... Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Refreshing Cached IP Addresses Mar 14 18:45:21 volumio-pi5 sudo[5916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 14 18:45:21 volumio-pi5 sudo[5916]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:21 volumio-pi5 sudo[5916]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:21 volumio-pi5 sudo[5918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 14 18:45:21 volumio-pi5 sudo[5918]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:21 volumio-pi5 sudo[5918]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:21 volumio-pi5 volumio[5889]: info: Loading plugin "services"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "alsa_controller"... Mar 14 18:45:22 volumio-pi5 sudo[5931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 14 18:45:22 volumio-pi5 sudo[5931]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "wizard"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "networkfs"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Starting Udev Watcher for removable devices Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Ignoring mount for partition: boot Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Ignoring mount for partition: volumio Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Ignoring mount for partition: volumio_data Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "volumio_command_line_client"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Plugin upnp is not enabled Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "my_music"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "mpd"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Plugin upnp_browser is not enabled Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "alarm-clock"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Plugin airplay_emulation is not enabled Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "last_100"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "webradio"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "i2s_dacs"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: I2S DAC not set, start Auto-detection Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "volumiodiscovery"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 14 18:45:22 volumio-pi5 node[5889]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 14 18:45:22 volumio-pi5 node[5889]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 14 18:45:22 volumio-pi5 volumio[5889]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 14 18:45:22 volumio-pi5 volumio[5889]: *** WARNING *** For more information see Mar 14 18:45:22 volumio-pi5 volumio[5889]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 14 18:45:22 volumio-pi5 volumio[5889]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 14 18:45:22 volumio-pi5 volumio[5889]: *** WARNING *** For more information see Mar 14 18:45:22 volumio-pi5 node[5889]: *** WARNING *** For more information see Mar 14 18:45:22 volumio-pi5 node[5889]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 14 18:45:22 volumio-pi5 node[5889]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 14 18:45:22 volumio-pi5 node[5889]: *** WARNING *** For more information see Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Discovery: Started advertising with name: Volumio-PI5 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "outputs"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "albumart"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Plugin example_plugin is not enabled Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "inputs"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "updater_comm"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Plugin mpdemulation is not enabled Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "rest_api"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading plugin "websocket"... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Starting Socket.io Server version 2.3.0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Plugin touch_display is not enabled Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Loading i18n strings for locale ru Mar 14 18:45:22 volumio-pi5 volumio[5889]: Updating browse sources language Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 18:45:22 volumio-pi5 volumio[5889]: Forking 3 albumart workers Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::initPlayerControls Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: Express server listening on port 3000 Mar 14 18:45:22 volumio-pi5 volumio[5889]: [Metrics] WebUI: 0s 777.71ms Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreStateMachine::resetVolumioState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreStateMachine::getcurrentVolume Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioRetrievevolume Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreStateMachine::pushState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioPushState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Cannot read play queue from file Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Volumio Network Manager: Network status updated: 3 Mar 14 18:45:22 volumio-pi5 volumio[5889]: verbose: New Socket.io Connection to 192.168.0.144 from 192.168.0.107 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.6 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 1 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreStateMachine::setRepeat null single undefined Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreStateMachine::pushState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioPushState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreStateMachine::setRandom null Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreStateMachine::pushState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioPushState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Setting Device type: Raspberry PI Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Completed loading Core Plugins Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Preparing to generate the ALSA configuration file Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Asound.conf file unchanged, so no further update is needed Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Output device has changed, restarting MPD Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: ___________ START PLUGINS ___________ Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: ControllerMpd::onStart: Initializing MPD Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Creating MPD Configuration file Mar 14 18:45:22 volumio-pi5 sudo[5984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 18:45:22 volumio-pi5 sudo[5985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 18:45:22 volumio-pi5 sudo[5985]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:22 volumio-pi5 sudo[5984]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: [1741952722410] CoreMusicLibrary::Adding element Last_100 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: [1741952722411] CoreMusicLibrary::Adding element Webradio Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:45:22 volumio-pi5 sudo[5984]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:22 volumio-pi5 sudo[5989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Initializing BBC Radios Mar 14 18:45:22 volumio-pi5 sudo[5989]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:22 volumio-pi5 systemd[1]: Stopping Music Player Daemon... Mar 14 18:45:22 volumio-pi5 sudo[5989]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:22 volumio-pi5 sudo[5991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 18:45:22 volumio-pi5 sudo[5991]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:22 volumio-pi5 systemd[1]: mpd.service: Succeeded. Mar 14 18:45:22 volumio-pi5 systemd[1]: Stopped Music Player Daemon. Mar 14 18:45:22 volumio-pi5 systemd[1]: Starting Music Player Daemon... Mar 14 18:45:22 volumio-pi5 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 14 18:45:22 volumio-pi5 systemd[1]: mpd.service: Succeeded. Mar 14 18:45:22 volumio-pi5 systemd[1]: Stopped Music Player Daemon. Mar 14 18:45:22 volumio-pi5 systemd[1]: Starting Music Player Daemon... Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Volumio Calling Home Mar 14 18:45:22 volumio-pi5 volumio[5889]: Starting albumart workers Mar 14 18:45:22 volumio-pi5 sudo[6005]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 14 18:45:22 volumio-pi5 sudo[6005]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:22 volumio-pi5 sudo[6005]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:22 volumio-pi5 volumio[5889]: Starting albumart workers Mar 14 18:45:22 volumio-pi5 volumio[5889]: Starting albumart workers Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetVisibleSources Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Received Get System Info Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Discovery: Getting this device information Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Listing playlists Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: MPD Permissions set Mar 14 18:45:22 volumio-pi5 volumio[5889]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Volumio called home Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 14 18:45:22 volumio-pi5 mpd[6009]: Mar 14 18:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 14 18:45:22 volumio-pi5 systemd[1]: Started Music Player Daemon. Mar 14 18:45:22 volumio-pi5 sudo[5991]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:22 volumio-pi5 sudo[5985]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: Completed starting Core Plugins Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: ------------------------------------------- Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: ----- MyVolumio plugins startup ---- Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: ------------------------------------------- Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 14 18:45:22 volumio-pi5 volumio[5889]: error: MPD error: The expression evaluated to a falsy value: Mar 14 18:45:22 volumio-pi5 volumio[5889]: assert.ok(self.idling) Mar 14 18:45:22 volumio-pi5 volumio[5889]: error: The expression evaluated to a falsy value: Mar 14 18:45:22 volumio-pi5 volumio[5889]: assert.ok(self.idling) Mar 14 18:45:22 volumio-pi5 volumio[5889]: info: MPD running with PID6009 Mar 14 18:45:22 volumio-pi5 volumio[5889]: ,establishing connection Mar 14 18:45:22 volumio-pi5 volumio[5889]: error: updateQueue error: null Mar 14 18:45:22 volumio-pi5 volumio[5889]: error: updateQueue error: null Mar 14 18:45:23 volumio-pi5 volumio[5889]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 14 18:45:23 volumio-pi5 volumio[5889]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Mar 14 18:45:25 volumio-pi5 volumio-remote-updater[799]: [2025-03-14 11:45:25] [connect] Successful connection Mar 14 18:45:25 volumio-pi5 volumio-remote-updater[799]: [2025-03-14 11:45:25] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741952725 101 Mar 14 18:45:25 volumio-pi5 volumio[5889]: 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: 3 Mar 14 18:45:26 volumio-pi5 sudo[5931]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:27 volumio-pi5 volumio[5889]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds Mar 14 18:45:27 volumio-pi5 volumio[5889]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 14 18:45:30 volumio-pi5 volumio[5889]: verbose: New Socket.io Connection to volumio.local from 192.168.0.107 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.6 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 4 Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetQueue Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CoreStateMachine::getQueue Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CorePlayQueue::getQueue Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Mar 14 18:45:30 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Adding plugin bluetooth to MyMusic Plugins Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Adding plugin multiroom to MyMusic Plugins Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Adding plugin metavolumio to MyMusic Plugins Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Adding plugin cd_controller to MyMusic Plugins Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Starting MyVolumio Remote Streaming Endpoints Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: MyVolumio login type: Token Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Starting Streaming Service Transparent Proxy Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Streaming services startup Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: Starting Streaming Daemon Mar 14 18:45:31 volumio-pi5 sudo[6057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 14 18:45:31 volumio-pi5 sudo[6057]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:31 volumio-pi5 sudo[6057]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:31 volumio-pi5 volumio[5889]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 14 18:45:31 volumio-pi5 volumio[5889]: error: Cannot start Volumio Streaming Daemon Mar 14 18:45:31 volumio-pi5 volumio[5889]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 14 18:45:31 volumio-pi5 volumio[5889]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 14 18:45:32 volumio-pi5 volumio[5889]: info: Cannot mount NAS NAS at system boot, trial number 3 ,retrying in 5 seconds Mar 14 18:45:32 volumio-pi5 volumio[5889]: STREAMING PROXY: Starting server on port 3245 Mar 14 18:45:32 volumio-pi5 volumio[5889]: Node JS runtime: 14 Mar 14 18:45:32 volumio-pi5 volumio[5889]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: MyVolumio token set successfully Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: MYVOLUMIO: Adding device Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: MYVOLUMIO: Evaluating Server Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: MyVolumio status changed Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: Streaming services startup Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: Starting Streaming Daemon Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: Removing browser output: myVolumio user plan is not superstar Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: Removing audio output: Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: Stoppping Tunnel 1 Mar 14 18:45:34 volumio-pi5 sudo[6152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 14 18:45:34 volumio-pi5 sudo[6152]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:34 volumio-pi5 sudo[6152]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:34 volumio-pi5 sudo[6155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 14 18:45:34 volumio-pi5 volumio[5889]: error: Cannot start Volumio Streaming Daemon Mar 14 18:45:34 volumio-pi5 sudo[6155]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:34 volumio-pi5 volumio[5889]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 14 18:45:34 volumio-pi5 volumio[5889]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 14 18:45:34 volumio-pi5 sudo[6155]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:34 volumio-pi5 volumio[5889]: info: Remote SSH Stopped Mar 14 18:45:35 volumio-pi5 volumio[5889]: info: Setting Geolocation for MyVolumio to eu10 Mar 14 18:45:35 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:35 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:36 volumio-pi5 volumio[5889]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 14 18:45:36 volumio-pi5 volumio[5889]: info: Updating MyVolumio device info Mar 14 18:45:36 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:36 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:36 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:36 volumio-pi5 volumio[5889]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 14 18:45:37 volumio-pi5 volumio[5889]: info: Cannot mount NAS NAS at system boot, trial number 4 ,retrying in 5 seconds Mar 14 18:45:40 volumio-pi5 volumio[5889]: info: MYVOLUMIO: Adding device Mar 14 18:45:40 volumio-pi5 volumio[5889]: info: MYVOLUMIO: Evaluating Server Mar 14 18:45:40 volumio-pi5 volumio[5889]: info: Setting Geolocation for MyVolumio to eu7 Mar 14 18:45:40 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:41 volumio-pi5 volumio[5889]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Mar 14 18:45:41 volumio-pi5 volumio[5889]: info: Updating MyVolumio device info Mar 14 18:45:41 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:41 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:41 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:42 volumio-pi5 volumio[5889]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Mar 14 18:45:42 volumio-pi5 volumio[5889]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Mar 14 18:45:46 volumio-pi5 volumio[5889]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/volumio/buster/armhf Mar 14 18:45:46 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 18:45:46 volumio-pi5 volumio[5889]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 14 18:45:46 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:46 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/fusiondsp/volumio/buster/armhf Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Folder /tmp/plugins removed Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Check plugin dependencies Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Checking if plugin already exists Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Rename folder Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Folder /tmp/downloaded_plugin.zip removed Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Move to category Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Checking if install.sh is present Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Executing install.sh Mar 14 18:45:49 volumio-pi5 sudo[6204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Mar 14 18:45:49 volumio-pi5 sudo[6204]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: creating filters folder and copying demo filters Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: copying demo flters Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/ Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/2XEQ15/ Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/PEQ/ Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/convfir/ Mar 14 18:45:49 volumio-pi5 sudo[6229]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Mar 14 18:45:49 volumio-pi5 sudo[6229]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/convfir/kef.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/convfir/test.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/EQ15/ Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/EQ15/.Bass-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/EQ15/.Classic-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/EQ15/.Voice-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: ./presets/EQ15/.Rock-FusionDsp.json Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Installing/fusiondsp dependencies Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Hit:1 http://raspbian.raspberrypi.org/raspbian buster InRelease Mar 14 18:45:49 volumio-pi5 volumio[5889]: info: Hit:2 http://archive.raspberrypi.org/debian buster InRelease Mar 14 18:45:50 volumio-pi5 volumio[5889]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: Reading package lists... Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetBrowseSources Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: Building dependency tree... Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: Reading state information... Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: All packages are up to date. Mar 14 18:45:51 volumio-pi5 sudo[6229]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:51 volumio-pi5 sudo[6430]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Mar 14 18:45:51 volumio-pi5 sudo[6430]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: Reading package lists... Mar 14 18:45:51 volumio-pi5 volumio[5889]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: Completed starting MyVolumio Plugin Mar 14 18:45:51 volumio-pi5 volumio[5889]: [Metrics] CommandRouter: 30s 275.08ms Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumiosetStartupVolume Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::Close All Modals sent Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: CoreCommandRouter::Close All Modals sent Mar 14 18:45:51 volumio-pi5 volumio[5889]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Mar 14 18:45:51 volumio-pi5 volumio[5889]: aplay: main:828: audio open error: Unknown error 524 Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: Building dependency tree... Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: Reading state information... Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: The following additional packages will be installed: Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: build-essential bzip2 dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8 Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libalgorithm-diff-perl libalgorithm-diff-xs-perl libalgorithm-merge-perl Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libasan5 libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libpython3-dev Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libpython3.7 libpython3.7-dev libstdc++-8-dev libubsan1 make patch Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python-pip-whl python3-asn1crypto python3-async-timeout python3-attr Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-cffi-backend python3-crypto python3-cryptography python3-dbus Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-dev python3-entrypoints python3-gi python3-keyring Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-keyrings.alt python3-multidict python3-secretstorage Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: Suggested packages: Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: bzip2-doc debian-keyring gcc-8-doc libstdc++6-8-dbg gcc-multilib autoconf Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: automake libtool flex bison gdb gcc-doc gcc-8-locales libgcc1-dbg Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libgomp1-dbg libitm1-dbg libatomic1-dbg libasan5-dbg liblsan0-dbg Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libtsan0-dbg libubsan1-dbg libmpx2-dbg libquadmath0-dbg libstdc++-8-doc Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: make-doc ed diffutils-doc python-attr-doc python-crypto-doc Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python-cryptography-doc python3-cryptography-vectors python-dbus-doc Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-dbus-dbg gnome-keyring libkf5wallet-bin gir1.2-gnomekeyring-1.0 Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python-secretstorage-doc python-setuptools-doc Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: The following NEW packages will be installed: Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: build-essential bzip2 dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8 Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libalgorithm-diff-perl libalgorithm-diff-xs-perl libalgorithm-merge-perl Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libasan5 libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libpython3-dev Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: libpython3.7 libpython3.7-dev libstdc++-8-dev libubsan1 make patch Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python-pip-whl python3-aiohttp python3-asn1crypto python3-async-timeout Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-attr python3-cffi-backend python3-crypto python3-cryptography Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-dbus python3-dev python3-entrypoints python3-gi python3-keyring Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-keyrings.alt python3-multidict python3-pip python3-secretstorage Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev Mar 14 18:45:52 volumio-pi5 volumio-remote-updater[799]: No test mode Mar 14 18:45:52 volumio-pi5 volumio-remote-updater[799]: No alpha test mode Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: 0 upgraded, 46 newly installed, 0 to remove and 2 not upgraded. Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: Need to get 72.4 MB of archives. Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: After this operation, 160 MB of additional disk space will be used. Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: Get:1 http://archive.raspberrypi.org/debian buster/main armhf python-pip-whl all 18.1-5+rpt1 [1591 kB] Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 14 18:45:52 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 14 18:45:53 volumio-pi5 volumio[5889]: info: Get:2 http://mirror.as43289.net/raspbian/raspbian buster/main armhf bzip2 armhf 1.0.6-9.2~deb10u2 [46.3 kB] Mar 14 18:45:53 volumio-pi5 volumio[5889]: info: Get:5 http://archive.raspberrypi.org/debian buster/main armhf python3-pip all 18.1-5+rpt1 [171 kB] Mar 14 18:45:53 volumio-pi5 volumio[5889]: info: Get:3 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libcc1-0 armhf 8.3.0-6+rpi1 [37.9 kB] Mar 14 18:45:53 volumio-pi5 volumio[5889]: info: Get:4 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libasan5 armhf 8.3.0-6+rpi1 [317 kB] Mar 14 18:45:54 volumio-pi5 volumio[5889]: info: Get:6 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libubsan1 armhf 8.3.0-6+rpi1 [103 kB] Mar 14 18:45:54 volumio-pi5 volumio[5889]: info: Get:7 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libgcc-8-dev armhf 8.3.0-6+rpi1 [595 kB] Mar 14 18:45:54 volumio-pi5 volumio[5889]: info: Get:8 http://mirror.as43289.net/raspbian/raspbian buster/main armhf gcc-8 armhf 8.3.0-6+rpi1 [7223 kB] Mar 14 18:45:56 volumio-pi5 volumio[5889]: info: Get:12 http://raspbian.raspberrypi.org/raspbian buster/main armhf g++ armhf 4:8.3.0-1+rpi2 [1632 B] Mar 14 18:45:56 volumio-pi5 volumio[5889]: info: Get:9 http://mirror.as43289.net/raspbian/raspbian buster/main armhf gcc armhf 4:8.3.0-1+rpi2 [5200 B] Mar 14 18:45:56 volumio-pi5 volumio[5889]: info: Get:10 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libstdc++-8-dev armhf 8.3.0-6+rpi1 [1545 kB] Mar 14 18:45:57 volumio-pi5 volumio[5889]: info: Get:11 http://mirror.as43289.net/raspbian/raspbian buster/main armhf g++-8 armhf 8.3.0-6+rpi1 [7464 kB] Mar 14 18:45:58 volumio-pi5 sudo[6463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 14 18:45:58 volumio-pi5 sudo[6463]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:58 volumio-pi5 sudo[6463]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:58 volumio-pi5 sudo[6465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 14 18:45:58 volumio-pi5 sudo[6465]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:45:58 volumio-pi5 sudo[6465]: pam_unix(sudo:session): session closed for user root Mar 14 18:45:58 volumio-pi5 volumio[5889]: info: Get:13 http://mirror.as43289.net/raspbian/raspbian buster/main armhf make armhf 4.2.1-1.2 [321 kB] Mar 14 18:45:58 volumio-pi5 volumio[5889]: info: Get:14 http://mirror.as43289.net/raspbian/raspbian buster/main armhf patch armhf 2.7.6-3+deb10u1 [115 kB] Mar 14 18:45:58 volumio-pi5 volumio[5889]: verbose: New Socket.io Connection to 192.168.0.144 from 192.168.0.107 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.6 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5 Mar 14 18:45:58 volumio-pi5 volumio[5889]: info: Get:15 http://mirror.as43289.net/raspbian/raspbian buster/main armhf dpkg-dev all 1.19.8 [1776 kB] Mar 14 18:45:58 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 14 18:45:58 volumio-pi5 volumio[5889]: info: BOOT COMPLETED Mar 14 18:45:58 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetVisibleSources Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Received Get System Info Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Discovery: Getting this device information Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Listing playlists Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:16 http://mirror.as43289.net/raspbian/raspbian buster/main armhf build-essential armhf 12.6 [7568 B] Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:17 http://mirror.as43289.net/raspbian/raspbian buster/main armhf dh-python all 3.20190308 [99.3 kB] Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:18 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libfakeroot armhf 1.23-1 [43.3 kB] Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:19 http://mirror.as43289.net/raspbian/raspbian buster/main armhf fakeroot armhf 1.23-1 [85.2 kB] Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:20 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libalgorithm-diff-perl all 1.19.03-2 [47.9 kB] Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:21 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libalgorithm-diff-xs-perl armhf 0.04-5+b1 [11.4 kB] Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:22 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libalgorithm-merge-perl all 0.08-3 [12.7 kB] Mar 14 18:45:59 volumio-pi5 volumio[5889]: info: Get:23 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libexpat1-dev armhf 2.2.6-2+deb10u7 [130 kB] Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: Get:25 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libpython3.7-dev armhf 3.7.3-2+deb10u7 [47.2 MB] Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: Received Get System Info Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: Discovery: Getting this device information Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: Get:24 http://raspbian.mirror.vu.lt/raspbian/raspbian buster/main armhf libpython3.7 armhf 3.7.3-2+deb10u7 [1252 kB] Mar 14 18:46:00 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: Received Get System Info Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: Discovery: Getting this device information Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:46:01 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 18:46:04 volumio-pi5 volumio[5889]: info: Get:38 http://raspbian.raspberrypi.org/raspbian buster/main armhf python3-dev armhf 3.7.3-1 [1264 B] Mar 14 18:46:08 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:26 http://mirror.as43289.net/raspbian/raspbian buster/main armhf libpython3-dev armhf 3.7.3-1 [20.1 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:27 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-multidict armhf 4.5.2-1 [52.9 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:28 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-yarl armhf 1.3.0-1 [44.0 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:29 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-async-timeout all 3.0.1-1 [6292 B] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:30 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-attr all 18.2.0-1 [37.3 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:31 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-aiohttp armhf 3.5.1-1+deb10u1 [241 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:32 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-asn1crypto all 0.24.0-1 [78.2 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:33 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-cffi-backend armhf 1.12.2-1 [70.1 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:34 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-crypto armhf 2.6.1-9+b1 [251 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:35 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-cryptography armhf 2.6.1-3+deb10u4 [184 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:36 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-dbus armhf 1.2.8-3 [95.9 kB] Mar 14 18:46:09 volumio-pi5 volumio[5889]: info: Get:37 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3.7-dev armhf 3.7.3-2+deb10u7 [527 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:39 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-entrypoints all 0.3-1 [5508 B] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:40 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-gi armhf 3.30.4-1 [161 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:41 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-secretstorage all 2.3.1-2 [14.2 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:42 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-keyring all 17.1.1-1 [43.1 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:43 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-keyrings.alt all 3.1.1-1 [18.2 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:44 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-setuptools all 40.8.0-1 [306 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:45 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-wheel all 0.32.3-2 [19.4 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Get:46 http://mirror.as43289.net/raspbian/raspbian buster/main armhf python3-xdg all 0.25-5 [35.9 kB] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Fetched 72.4 MB in 18s (4024 kB/s) Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Selecting previously unselected package bzip2. Mar 14 18:46:10 volumio-pi5 volumio[5889]: [620B blob data] Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Preparing to unpack .../00-bzip2_1.0.6-9.2~deb10u2_armhf.deb ... Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Unpacking bzip2 (1.0.6-9.2~deb10u2) ... Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libcc1-0:armhf. Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Preparing to unpack .../01-libcc1-0_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Unpacking libcc1-0:armhf (8.3.0-6+rpi1) ... Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libasan5:armhf. Mar 14 18:46:10 volumio-pi5 volumio[5889]: info: Preparing to unpack .../02-libasan5_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Unpacking libasan5:armhf (8.3.0-6+rpi1) ... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libubsan1:armhf. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Preparing to unpack .../03-libubsan1_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Unpacking libubsan1:armhf (8.3.0-6+rpi1) ... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libgcc-8-dev:armhf. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Preparing to unpack .../04-libgcc-8-dev_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Unpacking libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Enabling plugin touch_display Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Loading plugin "touch_display"... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: PLUGIN START: touch_display Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Loading i18n strings for locale ru Mar 14 18:46:11 volumio-pi5 volumio[5889]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:46:11 volumio-pi5 sudo[6535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Mar 14 18:46:11 volumio-pi5 sudo[6535]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:11 volumio-pi5 systemd[1]: Stopping Getty on tty1... Mar 14 18:46:11 volumio-pi5 sudo[6538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Mar 14 18:46:11 volumio-pi5 systemd[1]: getty@tty1.service: Main process exited, code=killed, status=15/TERM Mar 14 18:46:11 volumio-pi5 systemd[1]: getty@tty1.service: Succeeded. Mar 14 18:46:11 volumio-pi5 sudo[6538]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:11 volumio-pi5 systemd[1]: Stopped Getty on tty1. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: touch_display: No backlight interface detected. Mar 14 18:46:11 volumio-pi5 volumio[5889]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 14 18:46:11 volumio-pi5 sudo[6541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Mar 14 18:46:11 volumio-pi5 sudo[6541]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:11 volumio-pi5 sudo[6535]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:11 volumio-pi5 systemd[1]: Reloading. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: touch_display: systemctl stop getty@tty1.service succeeded. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Mar 14 18:46:11 volumio-pi5 sudo[6544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Mar 14 18:46:11 volumio-pi5 sudo[6544]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:11 volumio-pi5 sudo[6544]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:11 volumio-pi5 volumio[5889]: error: touch_display: Error setting file permissions for /etc/X11/xorg.conf.d/99-vc4.conf: Error: Command failed: /usr/bin/sudo /bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Mar 14 18:46:11 volumio-pi5 volumio[5889]: /bin/chmod: cannot access '/etc/X11/xorg.conf.d/99-vc4.conf': No such file or directory Mar 14 18:46:11 volumio-pi5 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Selecting previously unselected package gcc-8. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Preparing to unpack .../05-gcc-8_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Unpacking gcc-8 (8.3.0-6+rpi1) ... Mar 14 18:46:11 volumio-pi5 sudo[6538]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: touch_display: systemctl disable getty@tty1.service succeeded. Mar 14 18:46:11 volumio-pi5 systemd[1]: Reloading. Mar 14 18:46:11 volumio-pi5 systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Mar 14 18:46:11 volumio-pi5 sudo[6541]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: touch_display: systemctl daemon-reload succeeded. Mar 14 18:46:11 volumio-pi5 sudo[6582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Mar 14 18:46:11 volumio-pi5 sudo[6582]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:11 volumio-pi5 sudo[6582]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:11 volumio-pi5 volumio[5889]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Mar 14 18:46:11 volumio-pi5 volumio[5889]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Mar 14 18:46:11 volumio-pi5 volumio[5889]: info: Error: Error Mar 14 18:46:12 volumio-pi5 volumio[5889]: info: Selecting previously unselected package gcc. Mar 14 18:46:12 volumio-pi5 volumio[5889]: info: Preparing to unpack .../06-gcc_4%3a8.3.0-1+rpi2_armhf.deb ... Mar 14 18:46:12 volumio-pi5 volumio[5889]: info: Unpacking gcc (4:8.3.0-1+rpi2) ... Mar 14 18:46:12 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libstdc++-8-dev:armhf. Mar 14 18:46:12 volumio-pi5 volumio[5889]: info: Preparing to unpack .../07-libstdc++-8-dev_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:46:12 volumio-pi5 volumio[5889]: info: Unpacking libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Mar 14 18:46:15 volumio-pi5 volumio[5889]: info: Selecting previously unselected package g++-8. Mar 14 18:46:15 volumio-pi5 volumio[5889]: info: Preparing to unpack .../08-g++-8_8.3.0-6+rpi1_armhf.deb ... Mar 14 18:46:15 volumio-pi5 volumio[5889]: info: Unpacking g++-8 (8.3.0-6+rpi1) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package g++. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../09-g++_4%3a8.3.0-1+rpi2_armhf.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking g++ (4:8.3.0-1+rpi2) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package make. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../10-make_4.2.1-1.2_armhf.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking make (4.2.1-1.2) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package patch. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../11-patch_2.7.6-3+deb10u1_armhf.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking patch (2.7.6-3+deb10u1) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package dpkg-dev. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../12-dpkg-dev_1.19.8_all.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking dpkg-dev (1.19.8) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package build-essential. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../13-build-essential_12.6_armhf.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking build-essential (12.6) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package dh-python. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../14-dh-python_3.20190308_all.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking dh-python (3.20190308) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Received Get System Version Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Received Get System Info Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Discovery: Getting this device information Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CoreCommandRouter::volumioGetState Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CorePlayQueue::getTrack 0 Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libfakeroot:armhf. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../15-libfakeroot_1.23-1_armhf.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking libfakeroot:armhf (1.23-1) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package fakeroot. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../16-fakeroot_1.23-1_armhf.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking fakeroot (1.23-1) ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libalgorithm-diff-perl. Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Preparing to unpack .../17-libalgorithm-diff-perl_1.19.03-2_all.deb ... Mar 14 18:46:16 volumio-pi5 volumio[5889]: info: Unpacking libalgorithm-diff-perl (1.19.03-2) ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libalgorithm-diff-xs-perl. Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Preparing to unpack .../18-libalgorithm-diff-xs-perl_0.04-5+b1_armhf.deb ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Unpacking libalgorithm-diff-xs-perl (0.04-5+b1) ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libalgorithm-merge-perl. Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Preparing to unpack .../19-libalgorithm-merge-perl_0.08-3_all.deb ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Unpacking libalgorithm-merge-perl (0.08-3) ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libexpat1-dev:armhf. Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Preparing to unpack .../20-libexpat1-dev_2.2.6-2+deb10u7_armhf.deb ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Unpacking libexpat1-dev:armhf (2.2.6-2+deb10u7) ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libpython3.7:armhf. Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Preparing to unpack .../21-libpython3.7_3.7.3-2+deb10u7_armhf.deb ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Unpacking libpython3.7:armhf (3.7.3-2+deb10u7) ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Selecting previously unselected package libpython3.7-dev:armhf. Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Preparing to unpack .../22-libpython3.7-dev_3.7.3-2+deb10u7_armhf.deb ... Mar 14 18:46:17 volumio-pi5 volumio[5889]: info: Unpacking libpython3.7-dev:armhf (3.7.3-2+deb10u7) ... Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Enabling plugin fusiondsp Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Loading plugin "fusiondsp"... Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Preparing to generate the ALSA configuration file Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Asound.conf file unchanged, so no further update is needed Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Output device has changed, restarting MPD Mar 14 18:46:18 volumio-pi5 sudo[6756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 18:46:18 volumio-pi5 sudo[6756]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:18 volumio-pi5 sudo[6756]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: PLUGIN START: fusiondsp Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Loading i18n strings for locale ru Mar 14 18:46:18 volumio-pi5 sudo[6759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 18:46:18 volumio-pi5 sudo[6759]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:18 volumio-pi5 volumio[5889]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: FusionDsp - mixtype--------------------- None Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Preparing to generate the ALSA configuration file Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Done. Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: MPD Permissions set Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 systemd[1]: Stopping Music Player Daemon... Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Asound.conf file unchanged, so no further update is needed Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: Output device has changed, restarting MPD Mar 14 18:46:18 volumio-pi5 systemd[1]: mpd.service: Succeeded. Mar 14 18:46:18 volumio-pi5 systemd[1]: Stopped Music Player Daemon. Mar 14 18:46:18 volumio-pi5 sudo[6767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 14 18:46:18 volumio-pi5 sudo[6767]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: MPD Permissions set Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 14 18:46:18 volumio-pi5 sudo[6767]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:18 volumio-pi5 sudo[6770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 14 18:46:18 volumio-pi5 sudo[6770]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:18 volumio-pi5 systemd[1]: Starting Music Player Daemon... Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: FusionDsp - Mar 14 18:46:18 volumio-pi5 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 14 18:46:18 volumio-pi5 systemd[1]: mpd.service: Succeeded. Mar 14 18:46:18 volumio-pi5 systemd[1]: Stopped Music Player Daemon. Mar 14 18:46:18 volumio-pi5 systemd[1]: Starting Music Player Daemon... Mar 14 18:46:18 volumio-pi5 sudo[6776]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 14 18:46:18 volumio-pi5 sudo[6776]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:18 volumio-pi5 sudo[6776]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:18 volumio-pi5 volumio[5889]: info: FusionDsp - undefined Mar 14 18:46:18 volumio-pi5 mpd[6778]: Mar 14 18:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 14 18:46:18 volumio-pi5 systemd[1]: Started Music Player Daemon. Mar 14 18:46:18 volumio-pi5 sudo[6759]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:18 volumio-pi5 sudo[6770]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:18 volumio-pi5 volumio[5889]: error: MPD error: The expression evaluated to a falsy value: Mar 14 18:46:18 volumio-pi5 volumio[5889]: assert.ok(self.idling) Mar 14 18:46:18 volumio-pi5 volumio[5889]: error: The expression evaluated to a falsy value: Mar 14 18:46:18 volumio-pi5 volumio[5889]: assert.ok(self.idling) Mar 14 18:46:18 volumio-pi5 volumio[5889]: error: updateQueue error: null Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: camilladsp service started and running in background, instance 1 Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 14 18:46:20 volumio-pi5 volumio[5889]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 14 18:46:20 volumio-pi5 volumio[5889]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 14 18:46:20 volumio-pi5 volumio[5889]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: FusionDsp loaded Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 14 18:46:20 volumio-pi5 sudo[6791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 14 18:46:20 volumio-pi5 sudo[6791]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: Adding Signal Path Element [object Object] Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: Adding fusiondspeq DSP Signal Path Element Mar 14 18:46:20 volumio-pi5 volumio[5889]: info: FusionDsp - ---- installed callbackRead Mar 14 18:46:20 volumio-pi5 volumio[5889]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 18:46:20 volumio-pi5 volumio[5889]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 14 18:46:20 volumio-pi5 volumio[5889]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 14 18:46:20 volumio-pi5 volumio[5889]: at onErrorNT (internal/child_process.js:465:16) Mar 14 18:46:20 volumio-pi5 volumio[5889]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 14 18:46:20 volumio-pi5 volumio[5889]: at runNextTicks (internal/process/task_queues.js:62:3) Mar 14 18:46:20 volumio-pi5 volumio[5889]: at listOnTimeout (internal/timers.js:523:9) Mar 14 18:46:20 volumio-pi5 volumio[5889]: at processTimers (internal/timers.js:497:7) { Mar 14 18:46:20 volumio-pi5 volumio[5889]: errno: -2, Mar 14 18:46:20 volumio-pi5 volumio[5889]: code: 'ENOENT', Mar 14 18:46:20 volumio-pi5 volumio[5889]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 14 18:46:20 volumio-pi5 volumio[5889]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 14 18:46:20 volumio-pi5 volumio[5889]: spawnargs: [ Mar 14 18:46:20 volumio-pi5 volumio[5889]: '-p', Mar 14 18:46:20 volumio-pi5 volumio[5889]: 9876, Mar 14 18:46:20 volumio-pi5 volumio[5889]: '-o', Mar 14 18:46:20 volumio-pi5 volumio[5889]: '/tmp/camilladsp.log', Mar 14 18:46:20 volumio-pi5 volumio[5889]: '-l', Mar 14 18:46:20 volumio-pi5 volumio[5889]: 'warn', Mar 14 18:46:20 volumio-pi5 volumio[5889]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 14 18:46:20 volumio-pi5 volumio[5889]: ] Mar 14 18:46:20 volumio-pi5 volumio[5889]: } Mar 14 18:46:20 volumio-pi5 volumio[5889]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 14 18:46:20 volumio-pi5 sudo[6791]: pam_unix(sudo:session): session closed for user root Mar 14 18:46:20 volumio-pi5 sudo[6802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-14 18:45 Mar 14 18:46:20 volumio-pi5 sudo[6802]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"